builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1455041033.52 results: success (0) buildid: 20160209073956 builduid: 478860a535f74d8890059988c6e27322 revision: 15ab48ee0814 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.521029) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.521391) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.521665) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005032 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.575829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.576104) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.599468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.599738) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.674735) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.675032) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.675399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.675669) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-09 10:03:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2016-02-09 10:03:53 (230 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108947 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.799526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.799831) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.849644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:53.849971) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 15ab48ee0814 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 15ab48ee0814 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-09 10:03:53,847 Setting DEBUG logging. 2016-02-09 10:03:53,847 attempt 1/10 2016-02-09 10:03:53,847 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/15ab48ee0814?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 10:03:54,213 unpacking tar archive at: mozilla-beta-15ab48ee0814/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:54.529448) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:54.529750) ========= echo 15ab48ee0814 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'15ab48ee0814'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15ab48ee0814 program finished with exit code 0 elapsedTime=0.004890 script_repo_revision: '15ab48ee0814' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:54.586061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:54.586372) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 10:03:54.607118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-09 10:03:54.610431) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:03:54 INFO - MultiFileLogger online at 20160209 10:03:54 in /builds/slave/test-pgo 10:03:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:03:54 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:03:54 INFO - {'append_to_log': False, 10:03:54 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:03:54 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:03:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:03:54 INFO - 'branch': 'Mozilla-Beta', 10:03:54 INFO - 'buildbot_json_path': 'buildprops.json', 10:03:54 INFO - 'config_files': ('talos/linux_config.py',), 10:03:54 INFO - 'default_actions': ('clobber', 10:03:54 INFO - 'read-buildbot-config', 10:03:54 INFO - 'download-and-extract', 10:03:54 INFO - 'populate-webroot', 10:03:54 INFO - 'create-virtualenv', 10:03:54 INFO - 'install', 10:03:54 INFO - 'run-tests'), 10:03:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:03:54 INFO - 'download_minidump_stackwalk': True, 10:03:54 INFO - 'download_symbols': 'ondemand', 10:03:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:03:54 INFO - 'tooltool.py': '/tools/tooltool.py', 10:03:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:03:54 INFO - '/tools/misc-python/virtualenv.py')}, 10:03:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:03:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:03:54 INFO - 'installer_path': 'installer.exe', 10:03:54 INFO - 'log_level': 'info', 10:03:54 INFO - 'log_name': 'talos', 10:03:54 INFO - 'log_to_console': True, 10:03:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:03:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:03:54 INFO - 'opt_config_files': (), 10:03:54 INFO - 'pip_index': False, 10:03:54 INFO - 'sps_profile': False, 10:03:54 INFO - 'sps_profile_interval': 0, 10:03:54 INFO - 'suite': 'dromaeojs', 10:03:54 INFO - 'system_bits': '32', 10:03:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:03:54 INFO - 'title': 'talos-linux64-ix-022', 10:03:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:03:54 INFO - 'use_talos_json': True, 10:03:54 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:03:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:03:54 INFO - 'work_dir': 'build'} 10:03:54 INFO - ##### 10:03:54 INFO - ##### Running clobber step. 10:03:54 INFO - ##### 10:03:54 INFO - Running pre-action listener: _resource_record_pre_action 10:03:54 INFO - Running main action method: clobber 10:03:54 INFO - rmtree: /builds/slave/test-pgo/build 10:03:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:03:55 INFO - Running post-action listener: _resource_record_post_action 10:03:55 INFO - ##### 10:03:55 INFO - ##### Running read-buildbot-config step. 10:03:55 INFO - ##### 10:03:55 INFO - Running pre-action listener: _resource_record_pre_action 10:03:55 INFO - Running main action method: read_buildbot_config 10:03:55 INFO - Using buildbot properties: 10:03:55 INFO - { 10:03:55 INFO - "properties": { 10:03:55 INFO - "buildnumber": 75, 10:03:55 INFO - "product": "firefox", 10:03:55 INFO - "script_repo_revision": "production", 10:03:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:03:55 INFO - "repository": "", 10:03:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:03:55 INFO - "buildid": "20160209073956", 10:03:55 INFO - "slavename": "talos-linux64-ix-022", 10:03:55 INFO - "pgo_build": "True", 10:03:55 INFO - "basedir": "/builds/slave/test-pgo", 10:03:55 INFO - "project": "", 10:03:55 INFO - "platform": "ubuntu64_hw", 10:03:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:03:55 INFO - "slavebuilddir": "test", 10:03:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:03:55 INFO - "branch": "mozilla-beta", 10:03:55 INFO - "repo_path": "releases/mozilla-beta", 10:03:55 INFO - "stage_platform": "linux64-pgo", 10:03:55 INFO - "builduid": "478860a535f74d8890059988c6e27322", 10:03:55 INFO - "revision": "15ab48ee0814" 10:03:55 INFO - }, 10:03:55 INFO - "sourcestamp": { 10:03:55 INFO - "repository": "", 10:03:55 INFO - "hasPatch": false, 10:03:55 INFO - "project": "", 10:03:55 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:03:55 INFO - "changes": [ 10:03:55 INFO - { 10:03:55 INFO - "category": null, 10:03:55 INFO - "files": [ 10:03:55 INFO - { 10:03:55 INFO - "url": null, 10:03:55 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:03:55 INFO - } 10:03:55 INFO - ], 10:03:55 INFO - "repository": "", 10:03:55 INFO - "rev": "15ab48ee0814", 10:03:55 INFO - "who": "sendchange", 10:03:55 INFO - "when": 1455040959, 10:03:55 INFO - "number": 7583242, 10:03:55 INFO - "comments": "Bug 1246011: fixed PT comparising for PT_s without rtpmap. r=jesup a=sylvestre", 10:03:55 INFO - "project": "", 10:03:55 INFO - "at": "Tue 09 Feb 2016 10:02:39", 10:03:55 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:03:55 INFO - "revlink": "", 10:03:55 INFO - "properties": [ 10:03:55 INFO - [ 10:03:55 INFO - "buildid", 10:03:55 INFO - "20160209073956", 10:03:55 INFO - "Change" 10:03:55 INFO - ], 10:03:55 INFO - [ 10:03:55 INFO - "builduid", 10:03:55 INFO - "478860a535f74d8890059988c6e27322", 10:03:55 INFO - "Change" 10:03:55 INFO - ], 10:03:55 INFO - [ 10:03:55 INFO - "pgo_build", 10:03:55 INFO - "True", 10:03:55 INFO - "Change" 10:03:55 INFO - ] 10:03:55 INFO - ], 10:03:55 INFO - "revision": "15ab48ee0814" 10:03:55 INFO - } 10:03:55 INFO - ], 10:03:55 INFO - "revision": "15ab48ee0814" 10:03:55 INFO - } 10:03:55 INFO - } 10:03:55 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:03:55 INFO - Running post-action listener: _resource_record_post_action 10:03:55 INFO - ##### 10:03:55 INFO - ##### Running download-and-extract step. 10:03:55 INFO - ##### 10:03:55 INFO - Running pre-action listener: _resource_record_pre_action 10:03:55 INFO - Running main action method: download_and_extract 10:03:55 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/test_packages.json 10:03:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:03:55 INFO - Downloaded 1270 bytes. 10:03:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:03:55 INFO - Using the following test package requirements: 10:03:55 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:03:55 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:03:55 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'jsshell-linux-x86_64.zip'], 10:03:55 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:03:55 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:03:55 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:03:55 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:03:55 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:03:55 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:03:55 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:03:55 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:03:55 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:55 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:03:55 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:03:58 INFO - Downloaded 21581551 bytes. 10:03:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:03:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:03:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:03:59 INFO - Return code: 0 10:03:59 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:59 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:03:59 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:04:00 INFO - Downloaded 21581551 bytes. 10:04:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 10:04:00 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:04:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:04:01 INFO - Return code: 0 10:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:04:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:04:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:04:07 INFO - Downloaded 11132038 bytes. 10:04:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 10:04:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:04:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:04:07 INFO - Return code: 0 10:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:04:13 INFO - Downloaded 57950271 bytes. 10:04:13 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:13 INFO - mkdir: /builds/slave/test-pgo/properties 10:04:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:04:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:04:13 INFO - Contents: 10:04:13 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:13 INFO - Running post-action listener: _resource_record_post_action 10:04:13 INFO - Running post-action listener: set_extra_try_arguments 10:04:13 INFO - ##### 10:04:13 INFO - ##### Running populate-webroot step. 10:04:13 INFO - ##### 10:04:13 INFO - Running pre-action listener: _resource_record_pre_action 10:04:13 INFO - Running main action method: populate_webroot 10:04:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:13 INFO - '--tppagecycles', 10:04:13 INFO - '7'], 10:04:13 INFO - 'tests': ['tsvgm']}}, 10:04:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:04:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:13 INFO - 'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:13 INFO - 'tests': ['damp', 'tps']}, 10:04:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:13 INFO - 'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['damp', 'tps']}, 10:04:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:04:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:13 INFO - 'other': {'tests': ['a11yr', 10:04:13 INFO - 'ts_paint', 10:04:13 INFO - 'tpaint', 10:04:13 INFO - 'sessionrestore', 10:04:13 INFO - 'sessionrestore_no_auto_restore']}, 10:04:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['a11yr', 10:04:13 INFO - 'ts_paint', 10:04:13 INFO - 'tpaint', 10:04:13 INFO - 'sessionrestore', 10:04:13 INFO - 'sessionrestore_no_auto_restore']}, 10:04:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['a11yr', 10:04:13 INFO - 'ts_paint', 10:04:13 INFO - 'tpaint', 10:04:13 INFO - 'sessionrestore', 10:04:13 INFO - 'sessionrestore_no_auto_restore']}, 10:04:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:04:13 INFO - 'tests': ['a11yr', 10:04:13 INFO - 'ts_paint', 10:04:13 INFO - 'tpaint', 10:04:13 INFO - 'sessionrestore', 10:04:13 INFO - 'sessionrestore_no_auto_restore']}, 10:04:13 INFO - 'other_l64': {'tests': ['a11yr', 10:04:14 INFO - 'ts_paint', 10:04:14 INFO - 'tpaint', 10:04:14 INFO - 'sessionrestore', 10:04:14 INFO - 'sessionrestore_no_auto_restore']}, 10:04:14 INFO - 'other_nol64': {'tests': ['a11yr', 10:04:14 INFO - 'ts_paint', 10:04:14 INFO - 'tpaint', 10:04:14 INFO - 'sessionrestore', 10:04:14 INFO - 'sessionrestore_no_auto_restore']}, 10:04:14 INFO - 'svgr': {'tests': ['tsvgx', 10:04:14 INFO - 'tsvgr_opacity', 10:04:14 INFO - 'tart', 10:04:14 INFO - 'tscrollx', 10:04:14 INFO - 'cart']}, 10:04:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:04:14 INFO - 'tests': ['tsvgx', 10:04:14 INFO - 'tsvgr_opacity', 10:04:14 INFO - 'tart', 10:04:14 INFO - 'tscrollx', 10:04:14 INFO - 'cart']}, 10:04:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:14 INFO - 'tests': ['tp5o']}, 10:04:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:14 INFO - 'talos_options': ['--e10s'], 10:04:14 INFO - 'tests': ['tp5o']}, 10:04:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:14 INFO - 'talos_options': ['--xperf_path', 10:04:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:14 INFO - 'tests': ['tp5n']}, 10:04:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:14 INFO - 'talos_options': ['--e10s', 10:04:14 INFO - '--xperf_path', 10:04:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:14 INFO - 'tests': ['tp5n']}}, 10:04:14 INFO - 'talos.zip': {'path': '', 10:04:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:14 INFO - Running post-action listener: _resource_record_post_action 10:04:14 INFO - ##### 10:04:14 INFO - ##### Running create-virtualenv step. 10:04:14 INFO - ##### 10:04:14 INFO - Running pre-action listener: _resource_record_pre_action 10:04:14 INFO - Running main action method: create_virtualenv 10:04:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:04:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 10:04:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:04:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:14 INFO - Using real prefix '/usr' 10:04:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:04:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:16 INFO - Installing pip.................done. 10:04:16 INFO - Return code: 0 10:04:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:04:16 INFO - Using env: {'DISPLAY': ':0', 10:04:16 INFO - 'HOME': '/home/cltbld', 10:04:16 INFO - 'LANG': 'en_US.UTF-8', 10:04:16 INFO - 'LANGUAGE': 'en_US:en', 10:04:16 INFO - 'LOGNAME': 'cltbld', 10:04:16 INFO - 'MAIL': '/var/mail/cltbld', 10:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:16 INFO - 'MOZ_NO_REMOTE': '1', 10:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:16 INFO - 'NO_EM_RESTART': '1', 10:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:16 INFO - 'SHELL': '/bin/bash', 10:04:16 INFO - 'SHLVL': '1', 10:04:16 INFO - 'TERM': 'linux', 10:04:16 INFO - 'TMOUT': '86400', 10:04:16 INFO - 'USER': 'cltbld', 10:04:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:16 INFO - '_': '/tools/buildbot/bin/python'} 10:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:04:16 INFO - Cleaning up... 10:04:16 INFO - Return code: 0 10:04:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:04:16 INFO - Using env: {'DISPLAY': ':0', 10:04:16 INFO - 'HOME': '/home/cltbld', 10:04:16 INFO - 'LANG': 'en_US.UTF-8', 10:04:16 INFO - 'LANGUAGE': 'en_US:en', 10:04:16 INFO - 'LOGNAME': 'cltbld', 10:04:16 INFO - 'MAIL': '/var/mail/cltbld', 10:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:16 INFO - 'MOZ_NO_REMOTE': '1', 10:04:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:16 INFO - 'NO_EM_RESTART': '1', 10:04:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:16 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:16 INFO - 'SHELL': '/bin/bash', 10:04:16 INFO - 'SHLVL': '1', 10:04:16 INFO - 'TERM': 'linux', 10:04:16 INFO - 'TMOUT': '86400', 10:04:16 INFO - 'USER': 'cltbld', 10:04:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:16 INFO - '_': '/tools/buildbot/bin/python'} 10:04:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:17 INFO - Downloading/unpacking psutil>=0.7.1 10:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:18 INFO - Installing collected packages: psutil 10:04:18 INFO - Running setup.py install for psutil 10:04:19 INFO - building 'psutil._psutil_linux' extension 10:04:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:04:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:04:19 INFO - building 'psutil._psutil_posix' extension 10:04:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:04:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:04:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:19 INFO - Successfully installed psutil 10:04:19 INFO - Cleaning up... 10:04:19 INFO - Return code: 0 10:04:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:04:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:04:19 INFO - Using env: {'DISPLAY': ':0', 10:04:19 INFO - 'HOME': '/home/cltbld', 10:04:19 INFO - 'LANG': 'en_US.UTF-8', 10:04:19 INFO - 'LANGUAGE': 'en_US:en', 10:04:19 INFO - 'LOGNAME': 'cltbld', 10:04:19 INFO - 'MAIL': '/var/mail/cltbld', 10:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:19 INFO - 'MOZ_NO_REMOTE': '1', 10:04:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:19 INFO - 'NO_EM_RESTART': '1', 10:04:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:19 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:19 INFO - 'SHELL': '/bin/bash', 10:04:19 INFO - 'SHLVL': '1', 10:04:19 INFO - 'TERM': 'linux', 10:04:19 INFO - 'TMOUT': '86400', 10:04:19 INFO - 'USER': 'cltbld', 10:04:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:19 INFO - '_': '/tools/buildbot/bin/python'} 10:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:04:21 INFO - Installing collected packages: mozsystemmonitor 10:04:21 INFO - Running setup.py install for mozsystemmonitor 10:04:21 INFO - Successfully installed mozsystemmonitor 10:04:21 INFO - Cleaning up... 10:04:21 INFO - Return code: 0 10:04:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:21 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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:04:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:21 INFO - Using env: {'DISPLAY': ':0', 10:04:21 INFO - 'HOME': '/home/cltbld', 10:04:21 INFO - 'LANG': 'en_US.UTF-8', 10:04:21 INFO - 'LANGUAGE': 'en_US:en', 10:04:21 INFO - 'LOGNAME': 'cltbld', 10:04:21 INFO - 'MAIL': '/var/mail/cltbld', 10:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:21 INFO - 'MOZ_NO_REMOTE': '1', 10:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:21 INFO - 'NO_EM_RESTART': '1', 10:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:21 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:21 INFO - 'SHELL': '/bin/bash', 10:04:21 INFO - 'SHLVL': '1', 10:04:21 INFO - 'TERM': 'linux', 10:04:21 INFO - 'TMOUT': '86400', 10:04:21 INFO - 'USER': 'cltbld', 10:04:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:21 INFO - '_': '/tools/buildbot/bin/python'} 10:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:21 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:23 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:04:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:24 INFO - Downloading docopt-0.6.1.tar.gz 10:04:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:24 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:24 INFO - Running setup.py install for blobuploader 10:04:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:04:24 INFO - Running setup.py install for requests 10:04:25 INFO - Running setup.py install for docopt 10:04:25 INFO - Successfully installed blobuploader requests docopt 10:04:25 INFO - Cleaning up... 10:04:25 INFO - Return code: 0 10:04:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:25 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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:04:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:25 INFO - Using env: {'DISPLAY': ':0', 10:04:25 INFO - 'HOME': '/home/cltbld', 10:04:25 INFO - 'LANG': 'en_US.UTF-8', 10:04:25 INFO - 'LANGUAGE': 'en_US:en', 10:04:25 INFO - 'LOGNAME': 'cltbld', 10:04:25 INFO - 'MAIL': '/var/mail/cltbld', 10:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:25 INFO - 'MOZ_NO_REMOTE': '1', 10:04:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:25 INFO - 'NO_EM_RESTART': '1', 10:04:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:25 INFO - 'SHELL': '/bin/bash', 10:04:25 INFO - 'SHLVL': '1', 10:04:25 INFO - 'TERM': 'linux', 10:04:25 INFO - 'TMOUT': '86400', 10:04:25 INFO - 'USER': 'cltbld', 10:04:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:25 INFO - '_': '/tools/buildbot/bin/python'} 10:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:25 INFO - Running setup.py (path:/tmp/pip-as8LuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:25 INFO - Running setup.py (path:/tmp/pip-l7NsGG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:25 INFO - Running setup.py (path:/tmp/pip-PutpEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:25 INFO - Running setup.py (path:/tmp/pip-84pNE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:25 INFO - Running setup.py (path:/tmp/pip-EYH7Yf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:25 INFO - Running setup.py (path:/tmp/pip-meM7BQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:25 INFO - Running setup.py (path:/tmp/pip-Ahrxjq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:25 INFO - Running setup.py (path:/tmp/pip-88Mz2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:25 INFO - Running setup.py (path:/tmp/pip-D8RZTp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:26 INFO - Running setup.py (path:/tmp/pip-groW2f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:26 INFO - Running setup.py (path:/tmp/pip-cy65BW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:26 INFO - Running setup.py (path:/tmp/pip-4HMOKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:26 INFO - Running setup.py (path:/tmp/pip-ags597-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:26 INFO - Running setup.py (path:/tmp/pip-yfprTF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:26 INFO - Running setup.py (path:/tmp/pip-zuMdIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:26 INFO - Running setup.py (path:/tmp/pip-ooV73V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:26 INFO - Running setup.py (path:/tmp/pip-ZIOFlk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:26 INFO - Running setup.py install for manifestparser 10:04:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:04:26 INFO - Running setup.py install for mozcrash 10:04:26 INFO - Running setup.py install for mozdebug 10:04:26 INFO - Running setup.py install for mozdevice 10:04:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozfile 10:04:27 INFO - Running setup.py install for mozhttpd 10:04:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozinfo 10:04:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozInstall 10:04:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozleak 10:04:27 INFO - Running setup.py install for mozlog 10:04:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for moznetwork 10:04:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozprocess 10:04:27 INFO - Running setup.py install for mozprofile 10:04:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:04:27 INFO - Running setup.py install for mozrunner 10:04:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:04:28 INFO - Running setup.py install for mozscreenshot 10:04:28 INFO - Running setup.py install for moztest 10:04:28 INFO - Running setup.py install for mozversion 10:04:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:04:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:28 INFO - Cleaning up... 10:04:28 INFO - Return code: 0 10:04:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:04:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:28 INFO - Using env: {'DISPLAY': ':0', 10:04:28 INFO - 'HOME': '/home/cltbld', 10:04:28 INFO - 'LANG': 'en_US.UTF-8', 10:04:28 INFO - 'LANGUAGE': 'en_US:en', 10:04:28 INFO - 'LOGNAME': 'cltbld', 10:04:28 INFO - 'MAIL': '/var/mail/cltbld', 10:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:28 INFO - 'MOZ_NO_REMOTE': '1', 10:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:28 INFO - 'NO_EM_RESTART': '1', 10:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:28 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:28 INFO - 'SHELL': '/bin/bash', 10:04:28 INFO - 'SHLVL': '1', 10:04:28 INFO - 'TERM': 'linux', 10:04:28 INFO - 'TMOUT': '86400', 10:04:28 INFO - 'USER': 'cltbld', 10:04:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:28 INFO - '_': '/tools/buildbot/bin/python'} 10:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:28 INFO - Running setup.py (path:/tmp/pip-DNElkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:28 INFO - Running setup.py (path:/tmp/pip-jPpbJk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:28 INFO - Running setup.py (path:/tmp/pip-QYgWUw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:28 INFO - Running setup.py (path:/tmp/pip-PbhLRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:28 INFO - Running setup.py (path:/tmp/pip-hWQ2J6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 10:04:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:28 INFO - Running setup.py (path:/tmp/pip-1xWBEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:29 INFO - Running setup.py (path:/tmp/pip-zn7a_0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:29 INFO - Running setup.py (path:/tmp/pip-rtoB5k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:29 INFO - Running setup.py (path:/tmp/pip-nkerc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:29 INFO - Running setup.py (path:/tmp/pip-jydqA5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:29 INFO - Running setup.py (path:/tmp/pip-KtZiMB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:29 INFO - Running setup.py (path:/tmp/pip-lQNL8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:29 INFO - Running setup.py (path:/tmp/pip-MhTZNt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:29 INFO - Running setup.py (path:/tmp/pip-F5MyMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:29 INFO - Running setup.py (path:/tmp/pip-Hz57W8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:29 INFO - Running setup.py (path:/tmp/pip-vDIyuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 10:04:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:29 INFO - Running setup.py (path:/tmp/pip-_xLuDU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:04:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:31 INFO - Downloading blessings-1.6.tar.gz 10:04:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:31 INFO - Installing collected packages: blessings 10:04:31 INFO - Running setup.py install for blessings 10:04:31 INFO - Successfully installed blessings 10:04:31 INFO - Cleaning up... 10:04:31 INFO - Return code: 0 10:04:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:04:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:04:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:04:32 INFO - Reading from file tmpfile_stdout 10:04:32 INFO - Current package versions: 10:04:32 INFO - argparse == 1.2.1 10:04:32 INFO - blessings == 1.6 10:04:32 INFO - blobuploader == 1.2.4 10:04:32 INFO - docopt == 0.6.1 10:04:32 INFO - manifestparser == 1.1 10:04:32 INFO - mozInstall == 1.12 10:04:32 INFO - mozcrash == 0.16 10:04:32 INFO - mozdebug == 0.1 10:04:32 INFO - mozdevice == 0.47 10:04:32 INFO - mozfile == 1.2 10:04:32 INFO - mozhttpd == 0.7 10:04:32 INFO - mozinfo == 0.9 10:04:32 INFO - mozleak == 0.1 10:04:32 INFO - mozlog == 3.1 10:04:32 INFO - moznetwork == 0.27 10:04:32 INFO - mozprocess == 0.22 10:04:32 INFO - mozprofile == 0.27 10:04:32 INFO - mozrunner == 6.11 10:04:32 INFO - mozscreenshot == 0.1 10:04:32 INFO - mozsystemmonitor == 0.0 10:04:32 INFO - moztest == 0.7 10:04:32 INFO - mozversion == 1.4 10:04:32 INFO - psutil == 3.1.1 10:04:32 INFO - requests == 1.2.3 10:04:32 INFO - wsgiref == 0.1.2 10:04:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:32 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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 10:04:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:04:32 INFO - Using env: {'DISPLAY': ':0', 10:04:32 INFO - 'HOME': '/home/cltbld', 10:04:32 INFO - 'LANG': 'en_US.UTF-8', 10:04:32 INFO - 'LANGUAGE': 'en_US:en', 10:04:32 INFO - 'LOGNAME': 'cltbld', 10:04:32 INFO - 'MAIL': '/var/mail/cltbld', 10:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:32 INFO - 'MOZ_NO_REMOTE': '1', 10:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:32 INFO - 'NO_EM_RESTART': '1', 10:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:32 INFO - 'SHELL': '/bin/bash', 10:04:32 INFO - 'SHLVL': '1', 10:04:32 INFO - 'TERM': 'linux', 10:04:32 INFO - 'TMOUT': '86400', 10:04:32 INFO - 'USER': 'cltbld', 10:04:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:32 INFO - '_': '/tools/buildbot/bin/python'} 10:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:04:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:04:32 INFO - Cleaning up... 10:04:32 INFO - Return code: 0 10:04:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 10:04:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:04:32 INFO - Using env: {'DISPLAY': ':0', 10:04:32 INFO - 'HOME': '/home/cltbld', 10:04:32 INFO - 'LANG': 'en_US.UTF-8', 10:04:32 INFO - 'LANGUAGE': 'en_US:en', 10:04:32 INFO - 'LOGNAME': 'cltbld', 10:04:32 INFO - 'MAIL': '/var/mail/cltbld', 10:04:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:32 INFO - 'MOZ_NO_REMOTE': '1', 10:04:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:32 INFO - 'NO_EM_RESTART': '1', 10:04:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:32 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:32 INFO - 'SHELL': '/bin/bash', 10:04:32 INFO - 'SHLVL': '1', 10:04:32 INFO - 'TERM': 'linux', 10:04:32 INFO - 'TMOUT': '86400', 10:04:32 INFO - 'USER': 'cltbld', 10:04:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:32 INFO - '_': '/tools/buildbot/bin/python'} 10:04:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:32 INFO - Downloading/unpacking jsonschema 10:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:34 INFO - Downloading/unpacking functools32 (from jsonschema) 10:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:34 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:34 INFO - warning: no files found matching '*.txt' 10:04:34 INFO - no previously-included directories found matching 'build' 10:04:34 INFO - no previously-included directories found matching 'dist' 10:04:34 INFO - no previously-included directories found matching '.git*' 10:04:34 INFO - Installing collected packages: jsonschema, functools32 10:04:34 INFO - Running setup.py install for functools32 10:04:34 INFO - warning: no files found matching '*.txt' 10:04:34 INFO - no previously-included directories found matching 'build' 10:04:34 INFO - no previously-included directories found matching 'dist' 10:04:34 INFO - no previously-included directories found matching '.git*' 10:04:34 INFO - Successfully installed jsonschema functools32 10:04:34 INFO - Cleaning up... 10:04:34 INFO - Return code: 0 10:04:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:34 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 0x7f1d97bc9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1686600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:04:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 10:04:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:04:34 INFO - Using env: {'DISPLAY': ':0', 10:04:34 INFO - 'HOME': '/home/cltbld', 10:04:34 INFO - 'LANG': 'en_US.UTF-8', 10:04:34 INFO - 'LANGUAGE': 'en_US:en', 10:04:34 INFO - 'LOGNAME': 'cltbld', 10:04:34 INFO - 'MAIL': '/var/mail/cltbld', 10:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:34 INFO - 'MOZ_NO_REMOTE': '1', 10:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:34 INFO - 'NO_EM_RESTART': '1', 10:04:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:34 INFO - 'SHELL': '/bin/bash', 10:04:34 INFO - 'SHLVL': '1', 10:04:34 INFO - 'TERM': 'linux', 10:04:34 INFO - 'TMOUT': '86400', 10:04:34 INFO - 'USER': 'cltbld', 10:04:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:34 INFO - '_': '/tools/buildbot/bin/python'} 10:04:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:34 INFO - Downloading/unpacking flake8 10:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:04:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:04:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04: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 10:04:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:37 INFO - no previously-included directories found matching 'docs/_build' 10:04:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:04:37 INFO - Running setup.py install for pep8 10:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:04:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:04:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:04:37 INFO - no previously-included directories found matching 'docs/_build' 10:04:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:04:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:04:37 INFO - Cleaning up... 10:04:37 INFO - Return code: 0 10:04:37 INFO - Running post-action listener: _resource_record_post_action 10:04:37 INFO - Running post-action listener: _start_resource_monitoring 10:04:37 INFO - Starting resource monitoring. 10:04:37 INFO - ##### 10:04:37 INFO - ##### Running install step. 10:04:37 INFO - ##### 10:04:37 INFO - Running pre-action listener: _resource_record_pre_action 10:04:37 INFO - Running main action method: install 10:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:04:37 INFO - Reading from file tmpfile_stdout 10:04:37 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:04:37 INFO - Reading from file tmpfile_stdout 10:04:37 INFO - Output received: 10:04:37 INFO - Usage: mozinstall [options] installer 10:04:37 INFO - Options: 10:04:37 INFO - -h, --help show this help message and exit 10:04:37 INFO - -d DEST, --destination=DEST 10:04:37 INFO - Directory to install application into. [default: 10:04:37 INFO - "/builds/slave/test-pgo"] 10:04:37 INFO - --app=APP Application being installed. [default: firefox] 10:04:37 INFO - mkdir: /builds/slave/test-pgo/build/application 10:04:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 10:04:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 10:04:52 INFO - Reading from file tmpfile_stdout 10:04:52 INFO - Output received: 10:04:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:04:52 INFO - Running post-action listener: _resource_record_post_action 10:04:52 INFO - ##### 10:04:52 INFO - ##### Running run-tests step. 10:04:52 INFO - ##### 10:04:52 INFO - Running pre-action listener: _resource_record_pre_action 10:04:52 INFO - Running main action method: run_tests 10:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:04:52 INFO - Python 2.7.3 10:04:52 INFO - Return code: 0 10:04:52 INFO - grabbing minidump binary from tooltool 10:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:52 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 0x1715350>, '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 0x1716250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17166e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:04:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 10:04:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:04:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:52 INFO - Return code: 0 10:04:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:04:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:04:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:04:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:04:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:04:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:04:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:04:53 INFO - Return code: 0 10:04:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:04:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 10:04:53 INFO - Using env: {'DISPLAY': ':0', 10:04:53 INFO - 'HOME': '/home/cltbld', 10:04:53 INFO - 'LANG': 'en_US.UTF-8', 10:04:53 INFO - 'LANGUAGE': 'en_US:en', 10:04:53 INFO - 'LOGNAME': 'cltbld', 10:04:53 INFO - 'MAIL': '/var/mail/cltbld', 10:04:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:04:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:53 INFO - 'MOZ_NO_REMOTE': '1', 10:04:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:53 INFO - 'NO_EM_RESTART': '1', 10:04:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:53 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:04:53 INFO - 'SHELL': '/bin/bash', 10:04:53 INFO - 'SHLVL': '1', 10:04:53 INFO - 'TERM': 'linux', 10:04:53 INFO - 'TMOUT': '86400', 10:04:53 INFO - 'USER': 'cltbld', 10:04:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735', 10:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:53 INFO - '_': '/tools/buildbot/bin/python'} 10:04:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 10:04:53 INFO - mozversion INFO | application_buildid: 20160209073956 10:04:53 INFO - mozversion INFO | application_changeset: 15ab48ee08141010d9ec501654932fc9befdd485 10:04:53 INFO - mozversion INFO | application_display_name: Nightly 10:04:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:53 INFO - mozversion INFO | application_name: Firefox 10:04:53 INFO - mozversion INFO | application_remotingname: firefox 10:04:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:53 INFO - mozversion INFO | application_vendor: Mozilla 10:04:53 INFO - mozversion INFO | application_version: 45.0 10:04:53 INFO - mozversion INFO | platform_buildid: 20160209073956 10:04:53 INFO - mozversion INFO | platform_changeset: 15ab48ee08141010d9ec501654932fc9befdd485 10:04:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:04:53 INFO - mozversion INFO | platform_version: 45.0 10:04:53 INFO - 2016-02-09 10:04:53,803 DEBUG : using testdate: 1455041093 10:04:53 INFO - 2016-02-09 10:04:53,803 DEBUG : actual date: 1455041093 10:04:53 INFO - 2016-02-09 10:04:53,812 INFO : starting webserver on 'localhost:53518' 10:04:53 INFO - 2016-02-09 10:04:53,813 INFO : Starting test suite talos-linux64-ix-022 10:04:53 INFO - 2016-02-09 10:04:53,813 INFO : Starting test dromaeo_css 10:04:53 INFO - 2016-02-09 10:04:53,813 DEBUG : operating with platform_type : linux_ 10:04:53 INFO - 2016-02-09 10:04:53,814 INFO : Initialising browser for dromaeo_css test... 10:04:53 INFO - 2016-02-09 10:04:53,830 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcNBYa6/profile http://localhost:53518/getInfo.html 10:04:57 INFO - 2016-02-09 10:04:57,997 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:57 INFO - 2016-02-09 10:04:57,997 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:57 INFO - 2016-02-09 10:04:57,997 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:57 INFO - 2016-02-09 10:04:57,997 DEBUG : BROWSER_OUTPUT: __metrics 10:04:58 INFO - 2016-02-09 10:04:58,146 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:59 INFO - 2016-02-09 10:04:59,086 INFO : Browser initialized. 10:04:59 INFO - 2016-02-09 10:04:59,086 INFO : Running cycle 1/1 for dromaeo_css test... 10:04:59 INFO - 2016-02-09 10:04:59,087 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcNBYa6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:10 INFO - 2016-02-09 10:05:10,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 134238208 10:05:10 INFO - 2016-02-09 10:05:10,775 DEBUG : BROWSER_OUTPUT: 10:06:01 INFO - 2016-02-09 10:06:01,792 DEBUG : BROWSER_OUTPUT: 1455041161785 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:08:10 INFO - 2016-02-09 10:08:10,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53518/tests/dromaeo/cssquery-ext.html) 10:08:11 INFO - 2016-02-09 10:08:11,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 222162944 10:08:11 INFO - 2016-02-09 10:08:11,388 DEBUG : BROWSER_OUTPUT: 10:11:13 INFO - 2016-02-09 10:11:13,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-ext.html (next: http://localhost:53518/tests/dromaeo/cssquery-jquery.html) 10:11:13 INFO - 2016-02-09 10:11:13,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 213778432 10:11:13 INFO - 2016-02-09 10:11:13,953 DEBUG : BROWSER_OUTPUT: 10:14:15 INFO - 2016-02-09 10:14:15,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53518/tests/dromaeo/cssquery-mootools.html) 10:14:16 INFO - 2016-02-09 10:14:16,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 204533760 10:14:16 INFO - 2016-02-09 10:14:16,233 DEBUG : BROWSER_OUTPUT: 10:17:17 INFO - 2016-02-09 10:17:17,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53518/tests/dromaeo/cssquery-prototype.html) 10:17:18 INFO - 2016-02-09 10:17:18,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 201236480 10:17:18 INFO - 2016-02-09 10:17:18,524 DEBUG : BROWSER_OUTPUT: 10:20:20 INFO - 2016-02-09 10:20:20,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53518/tests/dromaeo/cssquery-yui.html) 10:20:21 INFO - 2016-02-09 10:20:21,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 196943872 10:20:21 INFO - 2016-02-09 10:20:21,558 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/dromaeo/cssquery-yui.html (next: http://localhost:53518/tests/dromaeo/cssquery-dojo.html) 10:23:23 INFO - 2016-02-09 10:23:23,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 211312640 10:23:23 INFO - 2016-02-09 10:23:23,768 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,770 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:23:23 INFO - 2016-02-09 10:23:23,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:23:23 INFO - 2016-02-09 10:23:23,770 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:23:23 INFO - 2016-02-09 10:23:23,770 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:23:23 INFO - 2016-02-09 10:23:23,772 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3319.7178239849613;3361.3109312590923;3362.260302733398;3379.239671074007;3386.20424200313;5604.775808967636;5606.187102870082;5607.803726869561;5612.326520817503;5618.803341883035;5628.32460104787;5629.60592758507;5631.239782629344;5635.126555383922;5646.548276137909;4961.553460188582;5008.924866127011;5110.8466745997675;5123.948760512403;5182.196759502283;5098.4136824265315;5113.590912726973;5124.359455068116;5126.871828204306;5128.589712822965;5001.299818025479;5010.123228435027;5053.444121146671;5101.4133374662015;5103.693778373291;5108.795648174068;5145.408278048017;5153.330067091291;5166.302549155891;5167.586593072545;5013.774380152865;5050.191969284897;5107.055194788976;5124.461931497213;5151.716655583941;5268.841934741964;5298.443663415324;5363.436839131874;5401.972990135024;5420.34955805302;5987;5992.041273396236;6028.608140470856;6032.939670603281;6036.0644100164545;5783;6046.062860256668;6051.273847138372;6056.96971515144;6058.575899687024;5541.251930989305;5552.305961754781;5626.718664066781;5631.915521267184;5667.206591077212;6168.938310616836;6170.413810687977;6170.660613666201;6171.475424588871;6176.073588961602;5585.916211256835;5694;6020.69896505173;6031.819045428557;6037.909431358533;6045.516358691294;6151.9692401538605;6155.169052177898;6156.907646385308;6158.846028849314;5965.970170149121;6000.909986350208;6004.7598096076545;6010.2186715726675;6027.8794424111275;5707.258056452634;5749.913751293734;5990.131430942576;5999.880002399927;6010.248718910137;4581.633469322446;4583.862484125481;4596.4024676791805;4609.170349337084;4609.400777898919;4114.136031433372;4128.958710412918;4129.401236820644;4159.188958153191;4161.417401563784;5496.31296087989;5515.779368825202;5599.496045355938;5615.831525054255;5630.155476678449;6002.009668404664;6024.337322894478;6031.668258245751;6044.969775151096;6053.4551890330085;5678.659280443187;5679.119736440858;5682.460166284279;5682.715864206773;5688.203651488795;4947.925781113287;5032.144535428986;5050.974745126251;5124.231365295235;5216.686998780086;6087.05650624154;6110.938890611126;6111.480524155408;6142.3550527194;6162.445379915829;5996.130561068708;6003.369646187088;6006.219191505076;6007.759689612367;6014.9097763534455;5907;6006.489448396936;6074.422929821837;6097.908531371944;6110.450059494667;5895.322037965689;5910.7931222407005;5923.585349025527;5934.910976335272;5948.345681974893;5719;6026.337102918587;6036.728347224298;6037.516998640186;6046.606970546901;5720.227769251264;5747.339056008613;5827.854303642273;5831.241938548132;5856.150858125633;5833.941660583339;5840.707964601668;5840.795572154954;5858.062709966385;5900.822975310747;5565.860853478695;5606.719664016701;5715.171300161536;5720.685362305113;5730.885382292414;5850.268716410449;5920.940790592039;5941.554383421347;5952.851178720567;5993.460588547052;5753.741081651252;5757.222774925499;5757.769689212385;5759.712014399347;5760.1935728998815 10:23:23 INFO - 2016-02-09 10:23:23,775 DEBUG : BROWSER_OUTPUT: |1;ext.html;600.4115966352974;620.6245221640904;635.1615867055485;636.9522285828563;646.9417752402283;31741.36517269656;41321;41384.79307603465;41518.16963660725;41563;45302.77348613252;45668.62994110174;45703.54296457034;45893.770531147384;45939.310910336375;7764.340031097336;7877.881831772528;8996.550172491381;9168.220701240403;10277.691669249934;10535.420551869644;10610.416427096507;10649.201309901788;10663.306885052485;10674.573017079347;10665.573377064908;10763.13894888407;10779.5688172473;10787;10796.298240614375;10626.36241825489;10709.892901071007;10721.678349649444;10730.302530335503;10743.247972641919;10435.060844523954;10540.314879532882;10596.364218146937;10607.098396636295;10607.416592087433;41892.581074189475;42222.366664500056;42277.15445691069;42384;42646;3782.5082739244;3847.288251673421;4011.83952641894;4025.3760667096353;4088.8364465421346;32037.6796232037;32480.675193248237;32572.18569535757;32606;32633.184170395692;3822.235552889433;4218.093109981338;4240.766757828318;4296.484421869364;4301.459991850291;282142;283733;284252;284460;284490;57410;58335.8332833341;64390.35609643938;71635.99999999895;72782;63533.68233158805;63602.36397636057;63893.68053159704;64006.35993640097;64114;17357;17500.737488937677;17567.64864702699;17580.472585822445;17587.472375828747;13073.934630326787;13108.541201057917;13117.803232951514;13147.802782958262;13296.06927515084;21539.461513461974;21588.676169857466;21608.459788505414;21797.782022179894;21829.890850545962;8356.331493480508;8477.152284771473;8529.488230706178;8532.616032278562;8589.914100858912;957.0907637744032;1046.8063408269495;1084.9367619732707;1087.993605914526;1089.2756317049232;28038.85980570125;28107.62598483714;28294.575581365883;28716.856415718205;28916.855415723207;1053.7154968158554;1100.3782862682558;1111.6776134920945;1155.8439610652622;1164.959226427071;14976.625584360478;17407;17733;17891;18115.81884181141;390772;392491;392774;392871;393621;57992.13011804826;58367;58396.416035839946;58400.415995839496;58407.12389314164;1464.9490713001883;1468.6695493514087;1478.0909740509724;1480.5484327280283;1490.783836343724;30043;33171.33657326888;33185.66814331922;33508;33905;50848;51439.22841157461;51538.48461515337;51581.48418515767;51596.22605660843;314442;320487;320604;320707;320757;32692;33801.661983379854;33895.491567626996;34130.14674633154;34200;43517.56482435135;43950;44299.11401771882;44710.3293450592;45009.09981800411;36894.87967434254;37034.8148259257;37937.24125517419;38185;38321.61678383181;28603.708313961983;36693;36771.63228367682;36881.44677829889;39459.40810887896;35106.29787404289;44393.33409998788;44397.55602444064;45071.77464112658;45604.315935261664;34036.82981585076;34142.487862681584;34581.82709086438;35331;39281.607183928936;26038.86980565085;26430.86784566065;26788.330291742084;26909.596356055066;27021.864890676206 10:23:23 INFO - 2016-02-09 10:23:23,775 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.89223017555094;388.80948335315696;390.3364280722771;395.0794648469067;396.2214249000713;13901.860981390184;15981.680366392666;17441.563960900985;18640.813591864076;18675.252989880424;17285.222165002575;17287.30850765971;17355.219015144317;18262.269509219648;18664.06679666018;6191.4118158774845;6381.968090159543;6393.104965304861;6418.454431373339;6419;4599.448066232057;4726.550977657117;6326.082718005887;6856.24581296057;7028.367446929776;6776.220734615508;6933.445324374064;6967;6994.195667498252;7001.649917504104;6949.687264073129;6958.930410695904;6970.059042029312;6976.127984002;6981.3367730065565;6601.768938087192;6689;6807.353301436405;6807.761728339485;6811.4550835933005;22891.198808041638;23317.067317307286;23346.883265583732;23530.82345882699;24152.516949661083;2633.210036988896;2657.2161212442375;2703.7566619004187;2717.415755612533;2760.5169095408223;15069.246537673182;15278.770818437732;15458.667874582488;15711.450099246471;16088.436904708396;1918.5587314917507;1970.1922211893054;2012.8892910889895;2071.2854065347433;2122.2359950417836;58238.708806455696;67666;67721;73927;76531.23468765296;15819;16128.354865805471;16141.192940352936;16157.596060098356;16202.351905923866;25050.624240636404;25196;25596.232113036265;25605.103821366163;25641.743582564308;9385;9571.952140239255;9583.472908989934;9610;9649.517524123907;8125.228103330174;8125.512469251746;8176.182381761776;8387.077421483631;8468.28019618327;7045.917267479421;8315.916840831514;8398.958005210057;8399.160083991552;8523.786905327292;1915.257116024411;1958.6180694764669;1965.3219639224444;1986.5232344237568;2000.5098750805855;1033.560736686905;1050.4537640426936;1063.0804354233687;1065.9946700266605;1103.4923934989995;16897.662046758996;17310.740338894928;17337;17617.471475855746;17910.731339029924;989.4360214677565;997.1773287038222;1000.4947501511836;1002.9348092373972;1037.968860934173;9745.61017559304;9864.65473708431;10044.29689921713;10071.295009349422;10126.987301269814;428774;429428;429634;444332.55667443556;606666;84608.57695711605;85632.57183714166;86213;86583.56708216418;89716;1202.326697049655;1206.8069108942702;1215.3497878635064;1217.9756404871853;1228.22621748298;15796.289166987282;15848.762268566212;15945.840541594436;16042.278097485409;16337.754933675767;36202.8189859049;36690.8165459171;36919.815400922824;38442.231155377296;38884.6111538881;49573.25640115474;50271.49728502814;50346.74826625844;50382;51753;9965.601375944882;10063.490476428595;10474.4239066849;10506.264561480928;10524;12121.69695757613;13255.66860828487;17606.295748170443;17678.32055954682;18368.448946531626;14856.405743770129;14867.776983345042;14942.402303907722;15325.6168595786;15347.61630959235;15260.313285902383;15325;15563.76654350163;15692.136932468367;15885.285162167962;15460.458883939009;15591.454299099478;16065.437709680105;16288;16450.588735281715;10377.325473844176;10569.471526423495;10667.453219283005;10715.571377144826;10721.839172412265;11209.103271738404;12147.514099435924;12379.257244565355;15785.526434206991;16257.59356016109 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1565.295616972362;1568.7803707480962;1788.8390044895957;1853.1012458957405;1863.8537299560767;8004.079530853946;8224.835503289938;8237.546934918577;8243.958780206105;8264.049634292058;6946.340097690724;7193.964030179842;7847.176046515119;7882.763517094482;8039.196080391958;2329.9883500582473;2339.7543257957923;2361.2798096580536;2365.420471984366;2365.9408514787183;2019.0712272354735;2337.0885354711677;2347.6713260143592;2405.9518809623796;2408.759124087595;2032.9695054574192;2335.1243283768586;2373.1575290771784;2374.2046414451092;2375.762423757628;2279.2136712834044;2284.234781348242;2291.59897018022;2339;2341.1454818990946;2320.8491448055825;2330.2077293720217;2343.847649902751;2352.658864464643;2384.1059602649007;8053.718119865776;8072.475289106189;8086.797830054237;8167.550784706838;8203.753887383387;4777.211760059586;4966.428860680996;4969.130402179604;4974.825881094144;4978.303037574742;3092.5206592978125;3099.9535006974916;3146.4179126861604;3147.3233254850315;3190.4416727072903;1048.1667074675652;1051.174827760212;1072.3458690198972;1083.0523292119397;1083.875354334246;11236.157288203418;11245.887541124566;11259.887401125965;11270.042046425982;11327.546898124065;4395.7142785718825;4396.076823867023;4440.666949978699;4444.622207112432;4471.910561788811;9589.42463452195;9600.183984361407;9616.807663846685;9617.23062155026;9622.037796220462;4965.627577931597;4992;4995.625328100335;4998.825041123616;5001.299818025479;4563.110193512233;4564.246899261651;4568.497465278817;4569.862904112815;4570.771461426915;3836.7889766063136;3837.76973381598;3853.8265778039495;3864.4589757433982;3891.805409729502;1087.983680244797;1129.2829053551054;1181.4033912873945;1194.3073017649742;1204.6085022367765;1152.608113241502;1177.3230392524333;1217.829503869459;1402.6002589262216;1420.2685616907302;7676.731314404081;7728.149903510609;7851.960740196262;7890;7932.127465978853;1122.7193201699574;1142.6857614156174;1192.2786714037882;1210.068247449459;1219.6463025722442;6222.564420490613;6247.937520624736;6313.77901773445;6325.8734825304155;6349.936500634934;9716;9796.26528010402;9815.705528834147;9951.402915825074;9989.30074894765;9547.2839537035;9686.806263874823;9799.11807937289;9839.508024598741;9869.259805514615;7647.388208943271;7696.499727517694;7761.6119194040075;7785.299323061065;7790.870323803017;7558;7665.770026898979;7673.271039251262;7681.15507294186;7696.461247712607;8519.787005324917;8779.12208779117;8789.516576588094;8806.735797926072;8867.68963086289;8855.468671879707;8856.11438856135;8876.245519130945;9011.143941325563;9158.313126515672;7055.753048643272;7117;7117.501774875709;7123.786286411416;7125;7871.055473343006;7920.287174154354;7970.960145199469;7973.601319934096;7974.401919855918;6369.649669268235;7436.144843343085;7496.7750967471065;7590.240975902366;7608.2391760823475;6823.727050918106;7380.18817930038;7415.703371865281;7450.515716478411;7516.812079698051;7138.785836424916;7153.3919616833155;7174.067371241706;7180.102487189101;7184.676689549087;6921.9968332685885;6945.236024037251;6986;6993.4055605274125;6999.475039371966;6835.658217089026;6882.483813713891;6902.344277293649;6912.412444942236;6913.51605387618 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: |4;prototype.html;372.66832519058033;382.70149283558834;383.7639851491333;383.9289731399693;389.828475470793;6203.813885583434;6208.6585237811905;6216.875662486747;6233.03387974864;6289.433950944414;5858.912116318259;5968.970155149218;6000.219971403722;6128.233970753656;6156.353582873801;4760.8333708320215;4774.952250477486;4790.401199850019;4802.375691160153;4812.422509298889;4544.84093056743;4803.519648035186;4808.591269742076;4815.831445899395;4820.084184005028;4579.908401831962;4614.584687378136;4678.625709943196;4691.577758001779;4718.457377401592;4684.578387945085;4688.906221875577;4695.436547614308;4699.929501057487;4701.858944231662;4158.854440094582;4161.334186530141;4161.52142503613;4175;4184.66522678185;5771.451712087345;5837.211976383176;5852.619579727347;5860.794872179454;5874.265716785402;5543.445655434464;5557.055300598908;5560.471755183251;5561.694106824123;5570.6657600543695;6524.184476940382;6527.836804079889;6536.182977127859;6537.93462065378;6545.345465453464;4682.906341873178;4684.5549672781035;4686.882827929295;4689.906201875978;4696;6561.7375304987745;6752.0209569612625;6800.115984921928;6803.455723542104;6804.897926531106;4750.501197374295;4782.52174782519;4785.569298763058;4788.952110478851;4792.592629626521;4844.515548445198;4848.151573474628;4850.078485087822;4850.708957462563;4854;5397.649152805055;5546.362168350692;5548.833534993876;5560.805371811967;5563.666180029211;6604.966975165094;6609.768658097039;6618.437432818168;6623.635700036544;6625.138731964814;1679.9160041997852;1708.1715368046487;1711.0503670462763;1713.6230029393514;1714.8370904764026;1156.1964434717959;1160.8316794064813;1165.650304908524;1184.0764203920955;1186.0689358853258;6374.521910856704;6376.776812811529;6381.361863813581;6390.297067322591;6392.7123279452535;6589.571677840925;6760.594364338155;6825.249222585511;6831.726730930806;6842.452603791685;6290.811275661737;6301.842453938597;6433.485321174295;6441.677916104176;6443.774467893695;3674.926501469956;3696.149885526344;3700.8149592520267;3701.370766969622;3705;6887.724491020404;7054.929450705427;7058.894116588255;7073.08049953513;7077.009218709385;6960.721571137098;6989.860202795916;7037.437005039585;7041.823954401181;7045.401140902978;6948.722051117999;7008.404285635676;7044.189918159374;7053.188883278489;7059.117610298816;6631;6771.86456270862;6840;6848.897266541106;6854.383105520527;6764.120664313607;6768.898466522907;6773.221079575912;6774.661266936732;6775.661216939035;6898.724051037902;6910.723571057101;6914.965425172842;6922.965385173042;7055.153381594037;4794.137055329935;4879.512048795092;4940.530649588283;4944.505549445027;4965.528274813887;6679.799606011828;6731.495137864582;6736.292689267556;6748;6753.932460675527;6654.800355989328;6664.233613134552;6668.599884006975;6670.83322916931;6673.632950187786;6500.252470965899;6617.7683781067435;6631.834204144935;6640;6650.135482387259;6501.609903405811;6503.51223658237;6523.510736694672;6532.281449040697;6535.57518761279;6630.436412904957;6641.734330626721;6643.56816806906;6652.4345430637;6655.534112612264;6251.0623406487575;6371.904421433775;6484.805455836333;6493.902591461227;6505.772297969548 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: |5;yui.html;905.6105874473975;929.3912487320803;932.2215949682015;933.1601558597262;942.6606421688193;13833.446662133516;14124.293785310732;14127.364268607911;14149.292535373228;14160.150390976523;12427.627171184879;12672.176308539938;13773.724525509484;13783.724325513484;13797.379117939692;748.8015675845905;759.1194214710937;890.6481939633857;894.9284057275435;895.9059298773633;907.9137481939239;916.9174774270315;926.2867591954225;926.9212116970066;929.2333824594702;951.3816019587289;961.2598299309527;961.9803008810683;962.2350231565922;962.4465932089076;945.6831961292941;950.1068995144611;953.0231512699469;955.3646824861459;956.1729104324778;697.5187120886623;706.1138271469324;709.5352544083634;710.24359057604;711.0152438872148;13694.109882857583;13710.588682339545;13844.377003034888;13846.30768461573;13901.721965560733;12551.372431378395;12904.548340808027;12943.288119153443;12957.157784743962;13325.34202470701;10975.451227438676;11079.50142243601;11157.497912593954;11200.943995280053;11389.601363952223;3823.8470461181796;3835.42468629705;3835.5589107252745;3875.2636998970106;3955.7626542407547;45920.77039614814;46090.539094609296;46280.53719462796;47167.29249061267;47525;10460.320079194827;10461.320014199053;10462.47687615616;10545.683629491128;10706.411147386969;19325.613487730167;19383;19432.4170274892;19521.707174392395;19567.510812229524;8045.195480451908;8071.394645401619;8159.551224682699;8294.875576866352;8357.414980951275;4303.462067241595;4308.482982042175;4357.150355680612;4374.540673229329;4547.090581883636;3177.3486435281175;3180.634227063871;3189.8086114833186;3195.584574005411;3206.7594930379846;531.4791504325782;548.6762809942073;549.6564647095565;564.9378568357478;569.02412362798;614.8432149801862;645.9289478157399;698.6541661877403;727.483486724421;745.7166276814776;8479.364047696325;8994.460332380078;9042.18620324174;9090.772730681785;9140.08599140094;691.4803649424454;702.255609054404;725.5537844225763;729.9890501642479;736.7310931510067;3994.6005399460405;4212.705110642226;4280.507741609755;4388.429504164502;4472;55477;56421;56802.43197568054;56808.43191568032;57633.42366576364;50842.49157508452;51786.48213517892;52676;53099.46900530945;53831.46168538343;45952;49569.25646115311;49703.50296497061;54314.728426357615;54745;8940.776480588038;8961.865572016555;8992.505412202392;9189.678361257324;9218.631254749735;36022.819885900404;36514.45228321524;36705;37535;37612.811935940146;43544.34683479814;46097;46687.53312466832;46969.29546056744;47624;11576.189666723585;11620.302781833117;11634.825477618011;11743;12620.873791261969;11866;11924.105692072955;12257.325847078497;12483.063770217452;13316.733665326832;11261.605843795427;11348.03541698965;11671.183017188716;11700.414979251174;11838.467268973089;11161.944190278997;11233.494492747683;11315.603953861575;11399.08807295431;11522.135839812216;10614.416207108683;10703.036726694634;11061.170412218955;11548.94225528867;11708.531658733897;8970.461772293422;9456.858147127936;9472.668456603986;9555.283353748358;9690.75773105678;8981;9200.861987070066;9278.443293402417;9411.024628426918;9470.56365770676 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: __startTimestamp1455042203769__endTimestamp 10:23:23 INFO - 2016-02-09 10:23:23,779 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5554.60 Median:5720.23 stddev:614.91 (10.7%) stddev-sans-first:591.27 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: Values: 3319.7 3361.3 3362.3 3379.2 3386.2 5604.8 5606.2 5607.8 5612.3 5618.8 5628.3 5629.6 5631.2 5635.1 5646.5 4961.6 5008.9 5110.8 5123.9 5182.2 5098.4 5113.6 5124.4 5126.9 5128.6 5001.3 5010.1 5053.4 5101.4 5103.7 5108.8 5145.4 5153.3 5166.3 5167.6 5013.8 5050.2 5107.1 5124.5 5151.7 5268.8 5298.4 5363.4 5402.0 5420.3 5987.0 5992.0 6028.6 6032.9 6036.1 5783.0 6046.1 6051.3 6057.0 6058.6 5541.3 5552.3 5626.7 5631.9 5667.2 6168.9 6170.4 6170.7 6171.5 6176.1 5585.9 5694.0 6020.7 6031.8 6037.9 6045.5 6152.0 6155.2 6156.9 6158.8 5966.0 6000.9 6004.8 6010.2 6027.9 5707.3 5749.9 5990.1 5999.9 6010.2 4581.6 4583.9 4596.4 4609.2 4609.4 4114.1 4129.0 4129.4 4159.2 4161.4 5496.3 5515.8 5599.5 5615.8 5630.2 6002.0 6024.3 6031.7 6045.0 6053.5 5678.7 5679.1 5682.5 5682.7 5688.2 4947.9 5032.1 5051.0 5124.2 5216.7 6087.1 6110.9 6111.5 6142.4 6162.4 5996.1 6003.4 6006.2 6007.8 6014.9 5907.0 6006.5 6074.4 6097.9 6110.5 5895.3 5910.8 5923.6 5934.9 5948.3 5719.0 6026.3 6036.7 6037.5 6046.6 5720.2 5747.3 5827.9 5831.2 5856.2 5833.9 5840.7 5840.8 5858.1 5900.8 5565.9 5606.7 5715.2 5720.7 5730.9 5850.3 5920.9 5941.6 5952.9 5993.5 5753.7 5757.2 5757.8 5759.7 5760.2 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,781 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51490.68 Median:34083.49 stddev:87720.77 (257.4%) stddev-sans-first:87883.63 10:23:23 INFO - 2016-02-09 10:23:23,782 DEBUG : BROWSER_OUTPUT: Values: 600.4 620.6 635.2 637.0 646.9 31741.4 41321.0 41384.8 41518.2 41563.0 45302.8 45668.6 45703.5 45893.8 45939.3 7764.3 7877.9 8996.6 9168.2 10277.7 10535.4 10610.4 10649.2 10663.3 10674.6 10665.6 10763.1 10779.6 10787.0 10796.3 10626.4 10709.9 10721.7 10730.3 10743.2 10435.1 10540.3 10596.4 10607.1 10607.4 41892.6 42222.4 42277.2 42384.0 42646.0 3782.5 3847.3 4011.8 4025.4 4088.8 32037.7 32480.7 32572.2 32606.0 32633.2 3822.2 4218.1 4240.8 4296.5 4301.5 282142.0 283733.0 284252.0 284460.0 284490.0 57410.0 58335.8 64390.4 71636.0 72782.0 63533.7 63602.4 63893.7 64006.4 64114.0 17357.0 17500.7 17567.6 17580.5 17587.5 13073.9 13108.5 13117.8 13147.8 13296.1 21539.5 21588.7 21608.5 21797.8 21829.9 8356.3 8477.2 8529.5 8532.6 8589.9 957.1 1046.8 1084.9 1088.0 1089.3 28038.9 28107.6 28294.6 28716.9 28916.9 1053.7 1100.4 1111.7 1155.8 1165.0 14976.6 17407.0 17733.0 17891.0 18115.8 390772.0 392491.0 392774.0 392871.0 393621.0 57992.1 58367.0 58396.4 58400.4 58407.1 1464.9 1468.7 1478.1 1480.5 1490.8 30043.0 33171.3 33185.7 33508.0 33905.0 50848.0 51439.2 51538.5 51581.5 51596.2 314442.0 320487.0 320604.0 320707.0 320757.0 32692.0 33801.7 33895.5 34130.1 34200.0 43517.6 43950.0 44299.1 44710.3 45009.1 36894.9 37034.8 37937.2 38185.0 38321.6 28603.7 36693.0 36771.6 36881.4 39459.4 35106.3 44393.3 44397.6 45071.8 45604.3 34036.8 34142.5 34581.8 35331.0 39281.6 26038.9 26430.9 26788.3 26909.6 27021.9 10:23:23 INFO - 2016-02-09 10:23:23,782 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,782 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28768.49 Median:23104.13 stddev:77477.57 (335.3%) stddev-sans-first:77665.61 10:23:23 INFO - 2016-02-09 10:23:23,782 DEBUG : BROWSER_OUTPUT: Values: 384.9 388.8 390.3 395.1 396.2 13901.9 15981.7 17441.6 18640.8 18675.3 17285.2 17287.3 17355.2 18262.3 18664.1 6191.4 6382.0 6393.1 6418.5 6419.0 4599.4 4726.6 6326.1 6856.2 7028.4 6776.2 6933.4 6967.0 6994.2 7001.6 6949.7 6958.9 6970.1 6976.1 6981.3 6601.8 6689.0 6807.4 6807.8 6811.5 22891.2 23317.1 23346.9 23530.8 24152.5 2633.2 2657.2 2703.8 2717.4 2760.5 15069.2 15278.8 15458.7 15711.5 16088.4 1918.6 1970.2 2012.9 2071.3 2122.2 58238.7 67666.0 67721.0 73927.0 76531.2 15819.0 16128.4 16141.2 16157.6 16202.4 25050.6 25196.0 25596.2 25605.1 25641.7 9385.0 9572.0 9583.5 9610.0 9649.5 8125.2 8125.5 8176.2 8387.1 8468.3 7045.9 8315.9 8399.0 8399.2 8523.8 1915.3 1958.6 1965.3 1986.5 2000.5 1033.6 1050.5 1063.1 1066.0 1103.5 16897.7 17310.7 17337.0 17617.5 17910.7 989.4 997.2 1000.5 1002.9 1038.0 9745.6 9864.7 10044.3 10071.3 10127.0 428774.0 429428.0 429634.0 444332.6 606666.0 84608.6 85632.6 86213.0 86583.6 89716.0 1202.3 1206.8 1215.3 1218.0 1228.2 15796.3 15848.8 15945.8 16042.3 16337.8 36202.8 36690.8 36919.8 38442.2 38884.6 49573.3 50271.5 50346.7 50382.0 51753.0 9965.6 10063.5 10474.4 10506.3 10524.0 12121.7 13255.7 17606.3 17678.3 18368.4 14856.4 14867.8 14942.4 15325.6 15347.6 15260.3 15325.0 15563.8 15692.1 15885.3 15460.5 15591.5 16065.4 16288.0 16450.6 10377.3 10569.5 10667.5 10715.6 10721.8 11209.1 12147.5 12379.3 15785.5 16257.6 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5727.66 Median:6596.69 stddev:2966.85 (45.0%) stddev-sans-first:2958.68 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: Values: 1565.3 1568.8 1788.8 1853.1 1863.9 8004.1 8224.8 8237.5 8244.0 8264.0 6946.3 7194.0 7847.2 7882.8 8039.2 2330.0 2339.8 2361.3 2365.4 2365.9 2019.1 2337.1 2347.7 2406.0 2408.8 2033.0 2335.1 2373.2 2374.2 2375.8 2279.2 2284.2 2291.6 2339.0 2341.1 2320.8 2330.2 2343.8 2352.7 2384.1 8053.7 8072.5 8086.8 8167.6 8203.8 4777.2 4966.4 4969.1 4974.8 4978.3 3092.5 3100.0 3146.4 3147.3 3190.4 1048.2 1051.2 1072.3 1083.1 1083.9 11236.2 11245.9 11259.9 11270.0 11327.5 4395.7 4396.1 4440.7 4444.6 4471.9 9589.4 9600.2 9616.8 9617.2 9622.0 4965.6 4992.0 4995.6 4998.8 5001.3 4563.1 4564.2 4568.5 4569.9 4570.8 3836.8 3837.8 3853.8 3864.5 3891.8 1088.0 1129.3 1181.4 1194.3 1204.6 1152.6 1177.3 1217.8 1402.6 1420.3 7676.7 7728.1 7852.0 7890.0 7932.1 1122.7 1142.7 1192.3 1210.1 1219.6 6222.6 6247.9 6313.8 6325.9 6349.9 9716.0 9796.3 9815.7 9951.4 9989.3 9547.3 9686.8 9799.1 9839.5 9869.3 7647.4 7696.5 7761.6 7785.3 7790.9 7558.0 7665.8 7673.3 7681.2 7696.5 8519.8 8779.1 8789.5 8806.7 8867.7 8855.5 8856.1 8876.2 9011.1 9158.3 7055.8 7117.0 7117.5 7123.8 7125.0 7871.1 7920.3 7971.0 7973.6 7974.4 6369.6 7436.1 7496.8 7590.2 7608.2 6823.7 7380.2 7415.7 7450.5 7516.8 7138.8 7153.4 7174.1 7180.1 7184.7 6922.0 6945.2 6986.0 6993.4 6999.5 6835.7 6882.5 6902.3 6912.4 6913.5 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5527.95 Median:6290.12 stddev:1640.66 (26.1%) stddev-sans-first:1598.99 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: Values: 372.7 382.7 383.8 383.9 389.8 6203.8 6208.7 6216.9 6233.0 6289.4 5858.9 5969.0 6000.2 6128.2 6156.4 4760.8 4775.0 4790.4 4802.4 4812.4 4544.8 4803.5 4808.6 4815.8 4820.1 4579.9 4614.6 4678.6 4691.6 4718.5 4684.6 4688.9 4695.4 4699.9 4701.9 4158.9 4161.3 4161.5 4175.0 4184.7 5771.5 5837.2 5852.6 5860.8 5874.3 5543.4 5557.1 5560.5 5561.7 5570.7 6524.2 6527.8 6536.2 6537.9 6545.3 4682.9 4684.6 4686.9 4689.9 4696.0 6561.7 6752.0 6800.1 6803.5 6804.9 4750.5 4782.5 4785.6 4789.0 4792.6 4844.5 4848.2 4850.1 4850.7 4854.0 5397.6 5546.4 5548.8 5560.8 5563.7 6605.0 6609.8 6618.4 6623.6 6625.1 1679.9 1708.2 1711.1 1713.6 1714.8 1156.2 1160.8 1165.7 1184.1 1186.1 6374.5 6376.8 6381.4 6390.3 6392.7 6589.6 6760.6 6825.2 6831.7 6842.5 6290.8 6301.8 6433.5 6441.7 6443.8 3674.9 3696.1 3700.8 3701.4 3705.0 6887.7 7054.9 7058.9 7073.1 7077.0 6960.7 6989.9 7037.4 7041.8 7045.4 6948.7 7008.4 7044.2 7053.2 7059.1 6631.0 6771.9 6840.0 6848.9 6854.4 6764.1 6768.9 6773.2 6774.7 6775.7 6898.7 6910.7 6915.0 6923.0 7055.2 4794.1 4879.5 4940.5 4944.5 4965.5 6679.8 6731.5 6736.3 6748.0 6753.9 6654.8 6664.2 6668.6 6670.8 6673.6 6500.3 6617.8 6631.8 6640.0 6650.1 6501.6 6503.5 6523.5 6532.3 6535.6 6630.4 6641.7 6643.6 6652.4 6655.5 6251.1 6371.9 6484.8 6493.9 6505.8 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: 10:23:23 INFO - 2016-02-09 10:23:23,783 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14192.14 Median:46484.04 stddev:16265.45 (35.0%) stddev-sans-first:16280.48 10:23:23 INFO - 2016-02-09 10:23:23,784 DEBUG : BROWSER_OUTPUT: Values: 905.6 929.4 932.2 933.2 942.7 13833.4 14124.3 14127.4 14149.3 14160.2 12427.6 12672.2 13773.7 13783.7 13797.4 748.8 759.1 890.6 894.9 895.9 907.9 916.9 926.3 926.9 929.2 951.4 961.3 962.0 962.2 962.4 945.7 950.1 953.0 955.4 956.2 697.5 706.1 709.5 710.2 711.0 13694.1 13710.6 13844.4 13846.3 13901.7 12551.4 12904.5 12943.3 12957.2 13325.3 10975.5 11079.5 11157.5 11200.9 11389.6 3823.8 3835.4 3835.6 3875.3 3955.8 45920.8 46090.5 46280.5 47167.3 47525.0 10460.3 10461.3 10462.5 10545.7 10706.4 19325.6 19383.0 19432.4 19521.7 19567.5 8045.2 8071.4 8159.6 8294.9 8357.4 4303.5 4308.5 4357.2 4374.5 4547.1 3177.3 3180.6 3189.8 3195.6 3206.8 531.5 548.7 549.7 564.9 569.0 614.8 645.9 698.7 727.5 745.7 8479.4 8994.5 9042.2 9090.8 9140.1 691.5 702.3 725.6 730.0 736.7 3994.6 4212.7 4280.5 4388.4 4472.0 55477.0 56421.0 56802.4 56808.4 57633.4 50842.5 51786.5 52676.0 53099.5 53831.5 45952.0 49569.3 49703.5 54314.7 54745.0 8940.8 8961.9 8992.5 9189.7 9218.6 36022.8 36514.5 36705.0 37535.0 37612.8 43544.3 46097.0 46687.5 46969.3 47624.0 11576.2 11620.3 11634.8 11743.0 12620.9 11866.0 11924.1 12257.3 12483.1 13316.7 11261.6 11348.0 11671.2 11700.4 11838.5 11161.9 11233.5 11315.6 11399.1 11522.1 10614.4 10703.0 11061.2 11548.9 11708.5 8970.5 9456.9 9472.7 9555.3 9690.8 8981.0 9200.9 9278.4 9411.0 9470.6 10:23:23 INFO - 2016-02-09 10:23:23,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:23:23 INFO - 2016-02-09 10:23:23,784 DEBUG : BROWSER_OUTPUT: 10:23:24 INFO - 2016-02-09 10:23:24,270 INFO : Browser exited with error code: 0 10:23:24 INFO - 2016-02-09 10:23:24,288 INFO : Completed test dromaeo_css (00:18:30) 10:23:24 INFO - 2016-02-09 10:23:24,288 INFO : Starting test kraken 10:23:24 INFO - 2016-02-09 10:23:24,288 DEBUG : operating with platform_type : linux_ 10:23:24 INFO - 2016-02-09 10:23:24,288 INFO : Initialising browser for kraken test... 10:23:24 INFO - 2016-02-09 10:23:24,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMBNLYH/profile http://localhost:53518/getInfo.html 10:23:28 INFO - 2016-02-09 10:23:28,475 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:23:28 INFO - 2016-02-09 10:23:28,475 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:23:28 INFO - 2016-02-09 10:23:28,475 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:23:28 INFO - 2016-02-09 10:23:28,476 DEBUG : BROWSER_OUTPUT: __metrics 10:23:28 INFO - 2016-02-09 10:23:28,653 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:23:29 INFO - 2016-02-09 10:23:29,410 INFO : Browser initialized. 10:23:29 INFO - 2016-02-09 10:23:29,410 INFO : Running cycle 1/1 for kraken test... 10:23:29 INFO - 2016-02-09 10:23:29,411 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMBNLYH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:23:41 INFO - 2016-02-09 10:23:41,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 131985408 10:23:41 INFO - 2016-02-09 10:23:41,093 DEBUG : BROWSER_OUTPUT: 10:23:43 INFO - 2016-02-09 10:23:43,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:44 INFO - 2016-02-09 10:23:44,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 164093952 10:23:44 INFO - 2016-02-09 10:23:44,112 DEBUG : BROWSER_OUTPUT: 10:23:46 INFO - 2016-02-09 10:23:46,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-dft) 10:23:47 INFO - 2016-02-09 10:23:47,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 161275904 10:23:47 INFO - 2016-02-09 10:23:47,247 DEBUG : BROWSER_OUTPUT: 10:23:50 INFO - 2016-02-09 10:23:50,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-fft) 10:23:50 INFO - 2016-02-09 10:23:50,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 158171136 10:23:50 INFO - 2016-02-09 10:23:50,579 DEBUG : BROWSER_OUTPUT: 10:23:52 INFO - 2016-02-09 10:23:52,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53518/tests/kraken/driver.html?testName=audio-oscillator) 10:23:53 INFO - 2016-02-09 10:23:53,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 160346112 10:23:53 INFO - 2016-02-09 10:23:53,116 DEBUG : BROWSER_OUTPUT: 10:23:55 INFO - 2016-02-09 10:23:55,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:55 INFO - 2016-02-09 10:23:55,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 157798400 10:23:55 INFO - 2016-02-09 10:23:55,856 DEBUG : BROWSER_OUTPUT: 10:23:58 INFO - 2016-02-09 10:23:58,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:59 INFO - 2016-02-09 10:23:59,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 158035968 10:23:59 INFO - 2016-02-09 10:23:59,234 DEBUG : BROWSER_OUTPUT: 10:24:02 INFO - 2016-02-09 10:24:02,559 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53518/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:03 INFO - 2016-02-09 10:24:03,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 157806592 10:24:03 INFO - 2016-02-09 10:24:03,126 DEBUG : BROWSER_OUTPUT: 10:24:05 INFO - 2016-02-09 10:24:05,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53518/tests/kraken/driver.html?testName=json-parse-financial) 10:24:06 INFO - 2016-02-09 10:24:06,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 158011392 10:24:06 INFO - 2016-02-09 10:24:06,419 DEBUG : BROWSER_OUTPUT: 10:24:07 INFO - 2016-02-09 10:24:07,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:08 INFO - 2016-02-09 10:24:08,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 164204544 10:24:08 INFO - 2016-02-09 10:24:08,530 DEBUG : BROWSER_OUTPUT: 10:24:10 INFO - 2016-02-09 10:24:10,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:10 INFO - 2016-02-09 10:24:10,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 160141312 10:24:10 INFO - 2016-02-09 10:24:10,901 DEBUG : BROWSER_OUTPUT: 10:24:12 INFO - 2016-02-09 10:24:12,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:13 INFO - 2016-02-09 10:24:13,438 DEBUG : BROWSER_OUTPUT: RSS: Main: 166797312 10:24:13 INFO - 2016-02-09 10:24:13,438 DEBUG : BROWSER_OUTPUT: 10:24:15 INFO - 2016-02-09 10:24:15,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:16 INFO - 2016-02-09 10:24:16,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 173481984 10:24:16 INFO - 2016-02-09 10:24:16,346 DEBUG : BROWSER_OUTPUT: 10:24:18 INFO - 2016-02-09 10:24:18,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:19 INFO - 2016-02-09 10:24:19,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 169545728 10:24:19 INFO - 2016-02-09 10:24:19,416 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53518/tests/kraken/driver.html?testName=ai-astar) 10:24:21 INFO - 2016-02-09 10:24:21,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 228143104 10:24:21 INFO - 2016-02-09 10:24:21,304 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,306 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:24:21 INFO - 2016-02-09 10:24:21,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:24:21 INFO - 2016-02-09 10:24:21,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:24:21 INFO - 2016-02-09 10:24:21,306 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:24:21 INFO - 2016-02-09 10:24:21,306 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;110;104;108;110;109;99;108;108;99 10:24:21 INFO - 2016-02-09 10:24:21,307 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;123;147;168;120;152;147;123;161;121 10:24:21 INFO - 2016-02-09 10:24:21,307 DEBUG : BROWSER_OUTPUT: |2;audio-dft;158;159;158;159;162;161;159;159;160;158 10:24:21 INFO - 2016-02-09 10:24:21,307 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;71;161;73;70;70;72;149;74 10:24:21 INFO - 2016-02-09 10:24:21,307 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;136;92;92;93;134;92;92;139 10:24:21 INFO - 2016-02-09 10:24:21,308 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;108;110;110;109;109;109;109;110;109;109 10:24:21 INFO - 2016-02-09 10:24:21,308 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;147;145;145;146;145;145;146;145 10:24:21 INFO - 2016-02-09 10:24:21,308 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 10:24:21 INFO - 2016-02-09 10:24:21,308 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;56;59;56;57;56;58;62;56 10:24:21 INFO - 2016-02-09 10:24:21,308 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;64;65;64;65;65 10:24:21 INFO - 2016-02-09 10:24:21,309 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;77;79;80;80;79;78;79;79;80 10:24:21 INFO - 2016-02-09 10:24:21,309 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;119;109;119;126;113;115;110;114;118 10:24:21 INFO - 2016-02-09 10:24:21,309 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;146;142;146;144;141;139;139;147;132 10:24:21 INFO - 2016-02-09 10:24:21,309 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;65;62;65;65;65;63;64;63 10:24:21 INFO - 2016-02-09 10:24:21,309 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:24:21 INFO - 2016-02-09 10:24:21,310 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:24:21 INFO - 2016-02-09 10:24:21,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,866 10:24:21 INFO - 2016-02-09 10:24:21,310 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:24:21 INFO - 2016-02-09 10:24:21,310 DEBUG : BROWSER_OUTPUT: __startTimestamp1455042261305__endTimestamp 10:24:21 INFO - 2016-02-09 10:24:21,310 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.20 Median:109.50 stddev:4.16 (3.8%) stddev-sans-first:4.40 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: Values: 107.0 110.0 104.0 108.0 110.0 109.0 99.0 108.0 108.0 99.0 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,314 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.70 Median:147.00 stddev:17.72 (12.1%) stddev-sans-first:18.73 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: Values: 145.0 123.0 147.0 168.0 120.0 152.0 147.0 123.0 161.0 121.0 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:159.30 Median:159.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: Values: 158.0 159.0 158.0 159.0 162.0 161.0 159.0 159.0 160.0 158.0 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:71.50 stddev:35.24 (49.3%) stddev-sans-first:36.81 10:24:21 INFO - 2016-02-09 10:24:21,315 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 71.0 161.0 73.0 70.0 70.0 72.0 149.0 74.0 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:92.00 stddev:21.31 (23.2%) stddev-sans-first:22.04 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 136.0 92.0 92.0 93.0 134.0 92.0 92.0 139.0 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,316 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 147.0 145.0 145.0 146.0 145.0 145.0 146.0 145.0 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.50 stddev:1.99 (3.5%) stddev-sans-first:2.06 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 56.0 59.0 56.0 57.0 56.0 58.0 62.0 56.0 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 10:24:21 INFO - 2016-02-09 10:24:21,317 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 64.0 65.0 64.0 65.0 65.0 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:0.99 (1.3%) stddev-sans-first:1.00 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: Values: 78.0 77.0 79.0 80.0 80.0 79.0 78.0 79.0 79.0 80.0 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.50 stddev:5.19 (4.5%) stddev-sans-first:5.25 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: Values: 111.0 119.0 109.0 119.0 126.0 113.0 115.0 110.0 114.0 118.0 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.00 stddev:4.47 (3.1%) stddev-sans-first:4.74 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: Values: 141.0 146.0 142.0 146.0 144.0 141.0 139.0 139.0 147.0 132.0 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.12 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 65.0 62.0 65.0 65.0 65.0 63.0 64.0 63.0 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:24:21 INFO - 2016-02-09 10:24:21,318 DEBUG : BROWSER_OUTPUT: 10:24:21 INFO - 2016-02-09 10:24:21,986 INFO : Browser exited with error code: 0 10:24:22 INFO - 2016-02-09 10:24:22,039 INFO : Completed test kraken (00:00:57) 10:24:22 INFO - 2016-02-09 10:24:22,039 INFO : Starting test v8_7 10:24:22 INFO - 2016-02-09 10:24:22,039 DEBUG : operating with platform_type : linux_ 10:24:22 INFO - 2016-02-09 10:24:22,039 INFO : Initialising browser for v8_7 test... 10:24:22 INFO - 2016-02-09 10:24:22,045 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIHI0PX/profile http://localhost:53518/getInfo.html 10:24:25 INFO - 2016-02-09 10:24:25,922 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:24:25 INFO - 2016-02-09 10:24:25,922 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:24:25 INFO - 2016-02-09 10:24:25,922 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:24:25 INFO - 2016-02-09 10:24:25,922 DEBUG : BROWSER_OUTPUT: __metrics 10:24:26 INFO - 2016-02-09 10:24:26,226 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:27 INFO - 2016-02-09 10:24:27,109 INFO : Browser initialized. 10:24:27 INFO - 2016-02-09 10:24:27,110 INFO : Running cycle 1/1 for v8_7 test... 10:24:27 INFO - 2016-02-09 10:24:27,110 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIHI0PX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:24:38 INFO - 2016-02-09 10:24:38,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 133132288 10:24:38 INFO - 2016-02-09 10:24:38,820 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,167 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53518/tests/v8_7/run.html (next: http://localhost:53518/tests/v8_7/run.html) 10:25:00 INFO - 2016-02-09 10:25:00,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 427311104 10:25:00 INFO - 2016-02-09 10:25:00,418 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,418 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:00 INFO - 2016-02-09 10:25:00,418 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |0;Richards;167.53224995811695 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.8233686368295 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |4;RayTrace;951.4747859181732 10:25:00 INFO - 2016-02-09 10:25:00,419 DEBUG : BROWSER_OUTPUT: |5;Earley;539.9568034557235 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: |6;Boyer;10479.166666666666 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: |7;RegExp;24512.19512195122 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: |8;Splay;518.3652353854113 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: __startTimestamp1455042300414__endTimestamp 10:25:00 INFO - 2016-02-09 10:25:00,420 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.53 Median:167.53 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: Values: 167.5 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,421 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.82 Median:170.82 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: Values: 170.8 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: Values: 278.6 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,422 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: Values: 5170.1 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: Values: 951.5 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:539.96 Median:539.96 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,423 DEBUG : BROWSER_OUTPUT: Values: 540.0 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10479.17 Median:10479.17 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: Values: 10479.2 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24512.20 Median:24512.20 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: Values: 24512.2 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,424 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:518.37 Median:518.37 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: Values: 518.4 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:00 INFO - 2016-02-09 10:25:00,425 DEBUG : BROWSER_OUTPUT: 10:25:01 INFO - 2016-02-09 10:25:01,090 INFO : Browser exited with error code: 0 10:25:01 INFO - 2016-02-09 10:25:01,101 INFO : Completed test v8_7 (00:00:39) 10:25:01 INFO - 2016-02-09 10:25:01,501 INFO : Completed test suite (00:20:07) 10:25:01 INFO - 2016-02-09 10:25:01,501 DEBUG : Working with test: dromaeo_css 10:25:01 INFO - 2016-02-09 10:25:01,502 DEBUG : Generating results file: dromaeo_css 10:25:01 INFO - 2016-02-09 10:25:01,503 DEBUG : Working with test: kraken 10:25:01 INFO - 2016-02-09 10:25:01,504 DEBUG : Generating results file: kraken 10:25:01 INFO - 2016-02-09 10:25:01,504 INFO : javascript benchmark 10:25:01 INFO - 2016-02-09 10:25:01,504 DEBUG : Working with test: v8_7 10:25:01 INFO - 2016-02-09 10:25:01,504 DEBUG : Generating results file: v8_7 10:25:01 INFO - 2016-02-09 10:25:01,505 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:01 INFO - 2016-02-09 10:25:01,562 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:25:01 INFO - 2016-02-09 10:25:01,562 DEBUG : process_Request line: dromaeo_css 7507.38 graph.html#tests=[[72,53,35]] 10:25:01 INFO - 2016-02-09 10:25:01,563 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:01 INFO - 2016-02-09 10:25:01,606 DEBUG : process_Request line: kraken 1471.30 graph.html#tests=[[232,53,35]] 10:25:01 INFO - 2016-02-09 10:25:01,606 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:01 INFO - 2016-02-09 10:25:01,639 DEBUG : process_Request line: v8_7 23230.07 graph.html#tests=[[230,53,35]] 10:25:01 INFO - 2016-02-09 10:25:01,641 INFO : javascript benchmark 10:25:01 INFO - 2016-02-09 10:25:01,645 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3319.7178239849613, 3361.3109312590923, 3362.260302733398, 3379.239671074007, 3386.20424200313, 5604.775808967636, 5606.187102870082, 5607.803726869561, 5612.326520817503, 5618.803341883035, 5628.32460104787, 5629.60592758507, 5631.239782629344, 5635.126555383922, 5646.548276137909, 4961.553460188582, 5008.924866127011, 5110.8466745997675, 5123.948760512403, 5182.196759502283, 5098.4136824265315, 5113.590912726973, 5124.359455068116, 5126.871828204306, 5128.589712822965, 5001.299818025479, 5010.123228435027, 5053.444121146671, 5101.4133374662015, 5103.693778373291, 5108.795648174068, 5145.408278048017, 5153.330067091291, 5166.302549155891, 5167.586593072545, 5013.774380152865, 5050.191969284897, 5107.055194788976, 5124.461931497213, 5151.716655583941, 5268.841934741964, 5298.443663415324, 5363.436839131874, 5401.972990135024, 5420.34955805302, 5987.0, 5992.041273396236, 6028.608140470856, 6032.939670603281, 6036.0644100164545, 5783.0, 6046.062860256668, 6051.273847138372, 6056.96971515144, 6058.575899687024, 5541.251930989305, 5552.305961754781, 5626.718664066781, 5631.915521267184, 5667.206591077212, 6168.938310616836, 6170.413810687977, 6170.660613666201, 6171.475424588871, 6176.073588961602, 5585.916211256835, 5694.0, 6020.69896505173, 6031.819045428557, 6037.909431358533, 6045.516358691294, 6151.9692401538605, 6155.169052177898, 6156.907646385308, 6158.846028849314, 5965.970170149121, 6000.909986350208, 6004.7598096076545, 6010.2186715726675, 6027.8794424111275, 5707.258056452634, 5749.913751293734, 5990.131430942576, 5999.880002399927, 6010.248718910137, 4581.633469322446, 4583.862484125481, 4596.4024676791805, 4609.170349337084, 4609.400777898919, 4114.136031433372, 4128.958710412918, 4129.401236820644, 4159.188958153191, 4161.417401563784, 5496.31296087989, 5515.779368825202, 5599.496045355938, 5615.831525054255, 5630.155476678449, 6002.009668404664, 6024.337322894478, 6031.668258245751, 6044.969775151096, 6053.4551890330085, 5678.659280443187, 5679.119736440858, 5682.460166284279, 5682.715864206773, 5688.203651488795, 4947.925781113287, 5032.144535428986, 5050.974745126251, 5124.231365295235, 5216.686998780086, 6087.05650624154, 6110.938890611126, 6111.480524155408, 6142.3550527194, 6162.445379915829, 5996.130561068708, 6003.369646187088, 6006.219191505076, 6007.759689612367, 6014.9097763534455, 5907.0, 6006.489448396936, 6074.422929821837, 6097.908531371944, 6110.450059494667, 5895.322037965689, 5910.7931222407005, 5923.585349025527, 5934.910976335272, 5948.345681974893, 5719.0, 6026.337102918587, 6036.728347224298, 6037.516998640186, 6046.606970546901, 5720.227769251264, 5747.339056008613, 5827.854303642273, 5831.241938548132, 5856.150858125633, 5833.941660583339, 5840.707964601668, 5840.795572154954, 5858.062709966385, 5900.822975310747, 5565.860853478695, 5606.719664016701, 5715.171300161536, 5720.685362305113, 5730.885382292414, 5850.268716410449, 5920.940790592039, 5941.554383421347, 5952.851178720567, 5993.460588547052, 5753.741081651252, 5757.222774925499, 5757.769689212385, 5759.712014399347, 5760.1935728998815], "unit": "ms", "name": "dojo.html", "value": 5515.090105636469}, {"lowerIsBetter": false, "replicates": [600.4115966352974, 620.6245221640904, 635.1615867055485, 636.9522285828563, 646.9417752402283, 31741.36517269656, 41321.0, 41384.79307603465, 41518.16963660725, 41563.0, 45302.77348613252, 45668.62994110174, 45703.54296457034, 45893.770531147384, 45939.310910336375, 7764.340031097336, 7877.881831772528, 8996.550172491381, 9168.220701240403, 10277.691669249934, 10535.420551869644, 10610.416427096507, 10649.201309901788, 10663.306885052485, 10674.573017079347, 10665.573377064908, 10763.13894888407, 10779.5688172473, 10787.0, 10796.298240614375, 10626.36241825489, 10709.892901071007, 10721.678349649444, 10730.302530335503, 10743.247972641919, 10435.060844523954, 10540.314879532882, 10596.364218146937, 10607.098396636295, 10607.416592087433, 41892.581074189475, 42222.366664500056, 42277.15445691069, 42384.0, 42646.0, 3782.5082739244, 3847.288251673421, 4011.83952641894, 4025.3760667096353, 4088.8364465421346, 32037.6796232037, 32480.675193248237, 32572.18569535757, 32606.0, 32633.184170395692, 3822.235552889433, 4218.093109981338, 4240.766757828318, 4296.484421869364, 4301.459991850291, 282142.0, 283733.0, 284252.0, 284460.0, 284490.0, 57410.0, 58335.8332833341, 64390.35609643938, 71635.99999999895, 72782.0, 63533.68233158805, 63602.36397636057, 63893.68053159704, 64006.35993640097, 64114.0, 17357.0, 17500.737488937677, 17567.64864702699, 17580.472585822445, 17587.472375828747, 13073.934630326787, 13108.541201057917, 13117.803232951514, 13147.802782958262, 13296.06927515084, 21539.461513461974, 21588.676169857466, 21608.459788505414, 21797.782022179894, 21829.890850545962, 8356.331493480508, 8477.152284771473, 8529.488230706178, 8532.616032278562, 8589.914100858912, 957.0907637744032, 1046.8063408269495, 1084.9367619732707, 1087.993605914526, 1089.2756317049232, 28038.85980570125, 28107.62598483714, 28294.575581365883, 28716.856415718205, 28916.855415723207, 1053.7154968158554, 1100.3782862682558, 1111.6776134920945, 1155.8439610652622, 1164.959226427071, 14976.625584360478, 17407.0, 17733.0, 17891.0, 18115.81884181141, 390772.0, 392491.0, 392774.0, 392871.0, 393621.0, 57992.13011804826, 58367.0, 58396.416035839946, 58400.415995839496, 58407.12389314164, 1464.9490713001883, 1468.6695493514087, 1478.0909740509724, 1480.5484327280283, 1490.783836343724, 30043.0, 33171.33657326888, 33185.66814331922, 33508.0, 33905.0, 50848.0, 51439.22841157461, 51538.48461515337, 51581.48418515767, 51596.22605660843, 314442.0, 320487.0, 320604.0, 320707.0, 320757.0, 32692.0, 33801.661983379854, 33895.491567626996, 34130.14674633154, 34200.0, 43517.56482435135, 43950.0, 44299.11401771882, 44710.3293450592, 45009.09981800411, 36894.87967434254, 37034.8148259257, 37937.24125517419, 38185.0, 38321.61678383181, 28603.708313961983, 36693.0, 36771.63228367682, 36881.44677829889, 39459.40810887896, 35106.29787404289, 44393.33409998788, 44397.55602444064, 45071.77464112658, 45604.315935261664, 34036.82981585076, 34142.487862681584, 34581.82709086438, 35331.0, 39281.607183928936, 26038.86980565085, 26430.86784566065, 26788.330291742084, 26909.596356055066, 27021.864890676206], "unit": "ms", "name": "ext.html", "value": 20335.359883534165}, {"lowerIsBetter": false, "replicates": [384.89223017555094, 388.80948335315696, 390.3364280722771, 395.0794648469067, 396.2214249000713, 13901.860981390184, 15981.680366392666, 17441.563960900985, 18640.813591864076, 18675.252989880424, 17285.222165002575, 17287.30850765971, 17355.219015144317, 18262.269509219648, 18664.06679666018, 6191.4118158774845, 6381.968090159543, 6393.104965304861, 6418.454431373339, 6419.0, 4599.448066232057, 4726.550977657117, 6326.082718005887, 6856.24581296057, 7028.367446929776, 6776.220734615508, 6933.445324374064, 6967.0, 6994.195667498252, 7001.649917504104, 6949.687264073129, 6958.930410695904, 6970.059042029312, 6976.127984002, 6981.3367730065565, 6601.768938087192, 6689.0, 6807.353301436405, 6807.761728339485, 6811.4550835933005, 22891.198808041638, 23317.067317307286, 23346.883265583732, 23530.82345882699, 24152.516949661083, 2633.210036988896, 2657.2161212442375, 2703.7566619004187, 2717.415755612533, 2760.5169095408223, 15069.246537673182, 15278.770818437732, 15458.667874582488, 15711.450099246471, 16088.436904708396, 1918.5587314917507, 1970.1922211893054, 2012.8892910889895, 2071.2854065347433, 2122.2359950417836, 58238.708806455696, 67666.0, 67721.0, 73927.0, 76531.23468765296, 15819.0, 16128.354865805471, 16141.192940352936, 16157.596060098356, 16202.351905923866, 25050.624240636404, 25196.0, 25596.232113036265, 25605.103821366163, 25641.743582564308, 9385.0, 9571.952140239255, 9583.472908989934, 9610.0, 9649.517524123907, 8125.228103330174, 8125.512469251746, 8176.182381761776, 8387.077421483631, 8468.28019618327, 7045.917267479421, 8315.916840831514, 8398.958005210057, 8399.160083991552, 8523.786905327292, 1915.257116024411, 1958.6180694764669, 1965.3219639224444, 1986.5232344237568, 2000.5098750805855, 1033.560736686905, 1050.4537640426936, 1063.0804354233687, 1065.9946700266605, 1103.4923934989995, 16897.662046758996, 17310.740338894928, 17337.0, 17617.471475855746, 17910.731339029924, 989.4360214677565, 997.1773287038222, 1000.4947501511836, 1002.9348092373972, 1037.968860934173, 9745.61017559304, 9864.65473708431, 10044.29689921713, 10071.295009349422, 10126.987301269814, 428774.0, 429428.0, 429634.0, 444332.55667443556, 606666.0, 84608.57695711605, 85632.57183714166, 86213.0, 86583.56708216418, 89716.0, 1202.326697049655, 1206.8069108942702, 1215.3497878635064, 1217.9756404871853, 1228.22621748298, 15796.289166987282, 15848.762268566212, 15945.840541594436, 16042.278097485409, 16337.754933675767, 36202.8189859049, 36690.8165459171, 36919.815400922824, 38442.231155377296, 38884.6111538881, 49573.25640115474, 50271.49728502814, 50346.74826625844, 50382.0, 51753.0, 9965.601375944882, 10063.490476428595, 10474.4239066849, 10506.264561480928, 10524.0, 12121.69695757613, 13255.66860828487, 17606.295748170443, 17678.32055954682, 18368.448946531626, 14856.405743770129, 14867.776983345042, 14942.402303907722, 15325.6168595786, 15347.61630959235, 15260.313285902383, 15325.0, 15563.76654350163, 15692.136932468367, 15885.285162167962, 15460.458883939009, 15591.454299099478, 16065.437709680105, 16288.0, 16450.588735281715, 10377.325473844176, 10569.471526423495, 10667.453219283005, 10715.571377144826, 10721.839172412265, 11209.103271738404, 12147.514099435924, 12379.257244565355, 15785.526434206991, 16257.59356016109], "unit": "ms", "name": "jquery.html", "value": 10253.348271283032}, {"lowerIsBetter": false, "replicates": [1565.295616972362, 1568.7803707480962, 1788.8390044895957, 1853.1012458957405, 1863.8537299560767, 8004.079530853946, 8224.835503289938, 8237.546934918577, 8243.958780206105, 8264.049634292058, 6946.340097690724, 7193.964030179842, 7847.176046515119, 7882.763517094482, 8039.196080391958, 2329.9883500582473, 2339.7543257957923, 2361.2798096580536, 2365.420471984366, 2365.9408514787183, 2019.0712272354735, 2337.0885354711677, 2347.6713260143592, 2405.9518809623796, 2408.759124087595, 2032.9695054574192, 2335.1243283768586, 2373.1575290771784, 2374.2046414451092, 2375.762423757628, 2279.2136712834044, 2284.234781348242, 2291.59897018022, 2339.0, 2341.1454818990946, 2320.8491448055825, 2330.2077293720217, 2343.847649902751, 2352.658864464643, 2384.1059602649007, 8053.718119865776, 8072.475289106189, 8086.797830054237, 8167.550784706838, 8203.753887383387, 4777.211760059586, 4966.428860680996, 4969.130402179604, 4974.825881094144, 4978.303037574742, 3092.5206592978125, 3099.9535006974916, 3146.4179126861604, 3147.3233254850315, 3190.4416727072903, 1048.1667074675652, 1051.174827760212, 1072.3458690198972, 1083.0523292119397, 1083.875354334246, 11236.157288203418, 11245.887541124566, 11259.887401125965, 11270.042046425982, 11327.546898124065, 4395.7142785718825, 4396.076823867023, 4440.666949978699, 4444.622207112432, 4471.910561788811, 9589.42463452195, 9600.183984361407, 9616.807663846685, 9617.23062155026, 9622.037796220462, 4965.627577931597, 4992.0, 4995.625328100335, 4998.825041123616, 5001.299818025479, 4563.110193512233, 4564.246899261651, 4568.497465278817, 4569.862904112815, 4570.771461426915, 3836.7889766063136, 3837.76973381598, 3853.8265778039495, 3864.4589757433982, 3891.805409729502, 1087.983680244797, 1129.2829053551054, 1181.4033912873945, 1194.3073017649742, 1204.6085022367765, 1152.608113241502, 1177.3230392524333, 1217.829503869459, 1402.6002589262216, 1420.2685616907302, 7676.731314404081, 7728.149903510609, 7851.960740196262, 7890.0, 7932.127465978853, 1122.7193201699574, 1142.6857614156174, 1192.2786714037882, 1210.068247449459, 1219.6463025722442, 6222.564420490613, 6247.937520624736, 6313.77901773445, 6325.8734825304155, 6349.936500634934, 9716.0, 9796.26528010402, 9815.705528834147, 9951.402915825074, 9989.30074894765, 9547.2839537035, 9686.806263874823, 9799.11807937289, 9839.508024598741, 9869.259805514615, 7647.388208943271, 7696.499727517694, 7761.6119194040075, 7785.299323061065, 7790.870323803017, 7558.0, 7665.770026898979, 7673.271039251262, 7681.15507294186, 7696.461247712607, 8519.787005324917, 8779.12208779117, 8789.516576588094, 8806.735797926072, 8867.68963086289, 8855.468671879707, 8856.11438856135, 8876.245519130945, 9011.143941325563, 9158.313126515672, 7055.753048643272, 7117.0, 7117.501774875709, 7123.786286411416, 7125.0, 7871.055473343006, 7920.287174154354, 7970.960145199469, 7973.601319934096, 7974.401919855918, 6369.649669268235, 7436.144843343085, 7496.7750967471065, 7590.240975902366, 7608.2391760823475, 6823.727050918106, 7380.18817930038, 7415.703371865281, 7450.515716478411, 7516.812079698051, 7138.785836424916, 7153.3919616833155, 7174.067371241706, 7180.102487189101, 7184.676689549087, 6921.9968332685885, 6945.236024037251, 6986.0, 6993.4055605274125, 6999.475039371966, 6835.658217089026, 6882.483813713891, 6902.344277293649, 6912.412444942236, 6913.51605387618], "unit": "ms", "name": "mootools.html", "value": 4704.414112611334}, {"lowerIsBetter": false, "replicates": [372.66832519058033, 382.70149283558834, 383.7639851491333, 383.9289731399693, 389.828475470793, 6203.813885583434, 6208.6585237811905, 6216.875662486747, 6233.03387974864, 6289.433950944414, 5858.912116318259, 5968.970155149218, 6000.219971403722, 6128.233970753656, 6156.353582873801, 4760.8333708320215, 4774.952250477486, 4790.401199850019, 4802.375691160153, 4812.422509298889, 4544.84093056743, 4803.519648035186, 4808.591269742076, 4815.831445899395, 4820.084184005028, 4579.908401831962, 4614.584687378136, 4678.625709943196, 4691.577758001779, 4718.457377401592, 4684.578387945085, 4688.906221875577, 4695.436547614308, 4699.929501057487, 4701.858944231662, 4158.854440094582, 4161.334186530141, 4161.52142503613, 4175.0, 4184.66522678185, 5771.451712087345, 5837.211976383176, 5852.619579727347, 5860.794872179454, 5874.265716785402, 5543.445655434464, 5557.055300598908, 5560.471755183251, 5561.694106824123, 5570.6657600543695, 6524.184476940382, 6527.836804079889, 6536.182977127859, 6537.93462065378, 6545.345465453464, 4682.906341873178, 4684.5549672781035, 4686.882827929295, 4689.906201875978, 4696.0, 6561.7375304987745, 6752.0209569612625, 6800.115984921928, 6803.455723542104, 6804.897926531106, 4750.501197374295, 4782.52174782519, 4785.569298763058, 4788.952110478851, 4792.592629626521, 4844.515548445198, 4848.151573474628, 4850.078485087822, 4850.708957462563, 4854.0, 5397.649152805055, 5546.362168350692, 5548.833534993876, 5560.805371811967, 5563.666180029211, 6604.966975165094, 6609.768658097039, 6618.437432818168, 6623.635700036544, 6625.138731964814, 1679.9160041997852, 1708.1715368046487, 1711.0503670462763, 1713.6230029393514, 1714.8370904764026, 1156.1964434717959, 1160.8316794064813, 1165.650304908524, 1184.0764203920955, 1186.0689358853258, 6374.521910856704, 6376.776812811529, 6381.361863813581, 6390.297067322591, 6392.7123279452535, 6589.571677840925, 6760.594364338155, 6825.249222585511, 6831.726730930806, 6842.452603791685, 6290.811275661737, 6301.842453938597, 6433.485321174295, 6441.677916104176, 6443.774467893695, 3674.926501469956, 3696.149885526344, 3700.8149592520267, 3701.370766969622, 3705.0, 6887.724491020404, 7054.929450705427, 7058.894116588255, 7073.08049953513, 7077.009218709385, 6960.721571137098, 6989.860202795916, 7037.437005039585, 7041.823954401181, 7045.401140902978, 6948.722051117999, 7008.404285635676, 7044.189918159374, 7053.188883278489, 7059.117610298816, 6631.0, 6771.86456270862, 6840.0, 6848.897266541106, 6854.383105520527, 6764.120664313607, 6768.898466522907, 6773.221079575912, 6774.661266936732, 6775.661216939035, 6898.724051037902, 6910.723571057101, 6914.965425172842, 6922.965385173042, 7055.153381594037, 4794.137055329935, 4879.512048795092, 4940.530649588283, 4944.505549445027, 4965.528274813887, 6679.799606011828, 6731.495137864582, 6736.292689267556, 6748.0, 6753.932460675527, 6654.800355989328, 6664.233613134552, 6668.599884006975, 6670.83322916931, 6673.632950187786, 6500.252470965899, 6617.7683781067435, 6631.834204144935, 6640.0, 6650.135482387259, 6501.609903405811, 6503.51223658237, 6523.510736694672, 6532.281449040697, 6535.57518761279, 6630.436412904957, 6641.734330626721, 6643.56816806906, 6652.4345430637, 6655.534112612264, 6251.0623406487575, 6371.904421433775, 6484.805455836333, 6493.902591461227, 6505.772297969548], "unit": "ms", "name": "prototype.html", "value": 5008.234628771756}, {"lowerIsBetter": false, "replicates": [905.6105874473975, 929.3912487320803, 932.2215949682015, 933.1601558597262, 942.6606421688193, 13833.446662133516, 14124.293785310732, 14127.364268607911, 14149.292535373228, 14160.150390976523, 12427.627171184879, 12672.176308539938, 13773.724525509484, 13783.724325513484, 13797.379117939692, 748.8015675845905, 759.1194214710937, 890.6481939633857, 894.9284057275435, 895.9059298773633, 907.9137481939239, 916.9174774270315, 926.2867591954225, 926.9212116970066, 929.2333824594702, 951.3816019587289, 961.2598299309527, 961.9803008810683, 962.2350231565922, 962.4465932089076, 945.6831961292941, 950.1068995144611, 953.0231512699469, 955.3646824861459, 956.1729104324778, 697.5187120886623, 706.1138271469324, 709.5352544083634, 710.24359057604, 711.0152438872148, 13694.109882857583, 13710.588682339545, 13844.377003034888, 13846.30768461573, 13901.721965560733, 12551.372431378395, 12904.548340808027, 12943.288119153443, 12957.157784743962, 13325.34202470701, 10975.451227438676, 11079.50142243601, 11157.497912593954, 11200.943995280053, 11389.601363952223, 3823.8470461181796, 3835.42468629705, 3835.5589107252745, 3875.2636998970106, 3955.7626542407547, 45920.77039614814, 46090.539094609296, 46280.53719462796, 47167.29249061267, 47525.0, 10460.320079194827, 10461.320014199053, 10462.47687615616, 10545.683629491128, 10706.411147386969, 19325.613487730167, 19383.0, 19432.4170274892, 19521.707174392395, 19567.510812229524, 8045.195480451908, 8071.394645401619, 8159.551224682699, 8294.875576866352, 8357.414980951275, 4303.462067241595, 4308.482982042175, 4357.150355680612, 4374.540673229329, 4547.090581883636, 3177.3486435281175, 3180.634227063871, 3189.8086114833186, 3195.584574005411, 3206.7594930379846, 531.4791504325782, 548.6762809942073, 549.6564647095565, 564.9378568357478, 569.02412362798, 614.8432149801862, 645.9289478157399, 698.6541661877403, 727.483486724421, 745.7166276814776, 8479.364047696325, 8994.460332380078, 9042.18620324174, 9090.772730681785, 9140.08599140094, 691.4803649424454, 702.255609054404, 725.5537844225763, 729.9890501642479, 736.7310931510067, 3994.6005399460405, 4212.705110642226, 4280.507741609755, 4388.429504164502, 4472.0, 55477.0, 56421.0, 56802.43197568054, 56808.43191568032, 57633.42366576364, 50842.49157508452, 51786.48213517892, 52676.0, 53099.46900530945, 53831.46168538343, 45952.0, 49569.25646115311, 49703.50296497061, 54314.728426357615, 54745.0, 8940.776480588038, 8961.865572016555, 8992.505412202392, 9189.678361257324, 9218.631254749735, 36022.819885900404, 36514.45228321524, 36705.0, 37535.0, 37612.811935940146, 43544.34683479814, 46097.0, 46687.53312466832, 46969.29546056744, 47624.0, 11576.189666723585, 11620.302781833117, 11634.825477618011, 11743.0, 12620.873791261969, 11866.0, 11924.105692072955, 12257.325847078497, 12483.063770217452, 13316.733665326832, 11261.605843795427, 11348.03541698965, 11671.183017188716, 11700.414979251174, 11838.467268973089, 11161.944190278997, 11233.494492747683, 11315.603953861575, 11399.08807295431, 11522.135839812216, 10614.416207108683, 10703.036726694634, 11061.170412218955, 11548.94225528867, 11708.531658733897, 8970.461772293422, 9456.858147127936, 9472.668456603986, 9555.283353748358, 9690.75773105678, 8981.0, 9200.861987070066, 9278.443293402417, 9411.024628426918, 9470.56365770676], "unit": "ms", "name": "yui.html", "value": 6607.394203813735}], "name": "dromaeo_css", "value": 7507.38096614289}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 110.0, 104.0, 108.0, 110.0, 109.0, 99.0, 108.0, 108.0, 99.0], "unit": "ms", "name": "ai-astar", "value": 106.2}, {"lowerIsBetter": true, "replicates": [145.0, 123.0, 147.0, 168.0, 120.0, 152.0, 147.0, 123.0, 161.0, 121.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.7}, {"lowerIsBetter": true, "replicates": [158.0, 159.0, 158.0, 159.0, 162.0, 161.0, 159.0, 159.0, 160.0, 158.0], "unit": "ms", "name": "audio-dft", "value": 159.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 71.0, 161.0, 73.0, 70.0, 70.0, 72.0, 149.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 136.0, 92.0, 92.0, 93.0, 134.0, 92.0, 92.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [108.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 59.0, 56.0, 57.0, 56.0, 58.0, 62.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 79.0, 80.0, 80.0, 79.0, 78.0, 79.0, 79.0, 80.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [111.0, 119.0, 109.0, 119.0, 126.0, 113.0, 115.0, 110.0, 114.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [141.0, 146.0, 142.0, 146.0, 144.0, 141.0, 139.0, 139.0, 147.0, 132.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 62.0, 65.0, 65.0, 65.0, 63.0, 64.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.1}], "name": "kraken", "value": 1471.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.53224995811695], "unit": "score", "name": "Richards", "value": 210.71763800000005}, {"lowerIsBetter": false, "replicates": [170.8233686368295], "unit": "score", "name": "DeltaBlue", "value": 387.05477199999996}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [539.9568034557235], "unit": "score", "name": "Earley", "value": 1234.2894759999995}, {"lowerIsBetter": false, "replicates": [10479.166666666666], "unit": "score", "name": "Boyer", "value": 63.59885487077532}, {"lowerIsBetter": false, "replicates": [24512.19512195122], "unit": "score", "name": "RegExp", "value": 37.1645621890547}, {"lowerIsBetter": false, "replicates": [518.3652353854113], "unit": "score", "name": "Splay", "value": 157.20768762475052}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23230.067812652185}]} 10:25:01 INFO - RETURN: dromaeo_css: 7507.38 10:25:01 INFO - RETURN: kraken: 1471.30 10:25:01 INFO - RETURN: v8_7: 23230.07 10:25:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23230.07"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1471.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7507.38"}}} 10:25:01 INFO - Return code: 0 10:25:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:01 INFO - # TBPL SUCCESS # 10:25:01 INFO - Running post-action listener: _resource_record_post_action 10:25:01 INFO - Running post-run listener: _resource_record_post_run 10:25:02 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 614400; Write bytes: 337739776; Read time: 468; Write time: 228680 10:25:02 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 37904384; Read time: 0; Write time: 32896 10:25:02 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 610304; Write bytes: 260210688; Read time: 368; Write time: 176840 10:25:02 INFO - Running post-run listener: _upload_blobber_files 10:25:02 INFO - Blob upload gear active. 10:25:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:25:02 INFO - Copying logs to upload dir... 10:25:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.319076 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-09 10:25:02.952117) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:25:02.955761) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009921 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1455032396/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-09 10:25:03.007802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:25:03.008183) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1455040916.377098-256606735 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 10:25:03.058402) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:25:03.058760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 10:25:03.059130) ========= ========= Total master_lag: 0.35 =========