builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1454522663.28 results: success (0) buildid: 20160203073629 builduid: d396a1d5fb1b42fa82f6f2e67ebfa649 revision: 625d8d4ac52e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.280442) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.280934) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.281451) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004705 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.309375) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.309681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.323428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.323909) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.375312) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.375806) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.376418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.376891) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-03 10:04:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-02-03 10:04:23 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.541045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.541371) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017675 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.591564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:23.591942) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 625d8d4ac52e --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 625d8d4ac52e --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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-03 10:04:23,789 Setting DEBUG logging. 2016-02-03 10:04:23,789 attempt 1/10 2016-02-03 10:04:23,789 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/625d8d4ac52e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-03 10:04:24,070 unpacking tar archive at: mozilla-beta-625d8d4ac52e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.561776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:24.168203) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:24.168638) ========= echo 625d8d4ac52e in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'625d8d4ac52e'] 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 625d8d4ac52e program finished with exit code 0 elapsedTime=0.004651 script_repo_revision: '625d8d4ac52e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:24.220044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:24.220362) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-03 10:04:24.234005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-03 10:04:24.234335) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:04:24 INFO - MultiFileLogger online at 20160203 10:04:24 in /builds/slave/test-pgo 10:04:24 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:04:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:04:24 INFO - {'append_to_log': False, 10:04:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:04:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:04:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:04:24 INFO - 'branch': 'Mozilla-Beta', 10:04:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:04:24 INFO - 'config_files': ('talos/linux_config.py',), 10:04:24 INFO - 'default_actions': ('clobber', 10:04:24 INFO - 'read-buildbot-config', 10:04:24 INFO - 'download-and-extract', 10:04:24 INFO - 'populate-webroot', 10:04:24 INFO - 'create-virtualenv', 10:04:24 INFO - 'install', 10:04:24 INFO - 'run-tests'), 10:04:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:04:24 INFO - 'download_minidump_stackwalk': True, 10:04:24 INFO - 'download_symbols': 'ondemand', 10:04:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:04:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:04:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:04:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:04:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:04:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:04:24 INFO - 'installer_path': 'installer.exe', 10:04:24 INFO - 'log_level': 'info', 10:04:24 INFO - 'log_name': 'talos', 10:04:24 INFO - 'log_to_console': True, 10:04:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:04:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:04:24 INFO - 'opt_config_files': (), 10:04:24 INFO - 'pip_index': False, 10:04:24 INFO - 'sps_profile': False, 10:04:24 INFO - 'sps_profile_interval': 0, 10:04:24 INFO - 'suite': 'dromaeojs', 10:04:24 INFO - 'system_bits': '32', 10:04:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:04:24 INFO - 'title': 'talos-linux64-ix-019', 10:04:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:04:24 INFO - 'use_talos_json': True, 10:04:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:04:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:04:24 INFO - 'work_dir': 'build'} 10:04:24 INFO - ##### 10:04:24 INFO - ##### Running clobber step. 10:04:24 INFO - ##### 10:04:24 INFO - Running pre-action listener: _resource_record_pre_action 10:04:24 INFO - Running main action method: clobber 10:04:24 INFO - rmtree: /builds/slave/test-pgo/build 10:04:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:04:25 INFO - Running post-action listener: _resource_record_post_action 10:04:25 INFO - ##### 10:04:25 INFO - ##### Running read-buildbot-config step. 10:04:25 INFO - ##### 10:04:25 INFO - Running pre-action listener: _resource_record_pre_action 10:04:25 INFO - Running main action method: read_buildbot_config 10:04:25 INFO - Using buildbot properties: 10:04:25 INFO - { 10:04:25 INFO - "properties": { 10:04:25 INFO - "buildnumber": 66, 10:04:25 INFO - "product": "firefox", 10:04:25 INFO - "script_repo_revision": "production", 10:04:25 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 10:04:25 INFO - "repository": "", 10:04:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 10:04:25 INFO - "buildid": "20160203073629", 10:04:25 INFO - "slavename": "talos-linux64-ix-019", 10:04:25 INFO - "pgo_build": "True", 10:04:25 INFO - "basedir": "/builds/slave/test-pgo", 10:04:25 INFO - "project": "", 10:04:25 INFO - "platform": "ubuntu64_hw", 10:04:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:04:25 INFO - "slavebuilddir": "test", 10:04:25 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:04:25 INFO - "branch": "mozilla-beta", 10:04:25 INFO - "repo_path": "releases/mozilla-beta", 10:04:25 INFO - "stage_platform": "linux64-pgo", 10:04:25 INFO - "builduid": "d396a1d5fb1b42fa82f6f2e67ebfa649", 10:04:25 INFO - "revision": "625d8d4ac52e" 10:04:25 INFO - }, 10:04:25 INFO - "sourcestamp": { 10:04:25 INFO - "repository": "", 10:04:25 INFO - "hasPatch": false, 10:04:25 INFO - "project": "", 10:04:25 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:04:25 INFO - "changes": [ 10:04:25 INFO - { 10:04:25 INFO - "category": null, 10:04:25 INFO - "files": [ 10:04:25 INFO - { 10:04:25 INFO - "url": null, 10:04:25 INFO - "name": "http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2" 10:04:25 INFO - } 10:04:25 INFO - ], 10:04:25 INFO - "repository": "", 10:04:25 INFO - "rev": "625d8d4ac52e", 10:04:25 INFO - "who": "sendchange", 10:04:25 INFO - "when": 1454522526, 10:04:25 INFO - "number": 7557528, 10:04:25 INFO - "comments": "Bug 1243882 - Block e10s for locales based on Firefox_s locale, not the OS. r=ehsan, a=sylvestre", 10:04:25 INFO - "project": "", 10:04:25 INFO - "at": "Wed 03 Feb 2016 10:02:06", 10:04:25 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 10:04:25 INFO - "revlink": "", 10:04:25 INFO - "properties": [ 10:04:25 INFO - [ 10:04:25 INFO - "buildid", 10:04:25 INFO - "20160203073629", 10:04:25 INFO - "Change" 10:04:25 INFO - ], 10:04:25 INFO - [ 10:04:25 INFO - "builduid", 10:04:25 INFO - "d396a1d5fb1b42fa82f6f2e67ebfa649", 10:04:25 INFO - "Change" 10:04:25 INFO - ], 10:04:25 INFO - [ 10:04:25 INFO - "pgo_build", 10:04:25 INFO - "True", 10:04:25 INFO - "Change" 10:04:25 INFO - ] 10:04:25 INFO - ], 10:04:25 INFO - "revision": "625d8d4ac52e" 10:04:25 INFO - } 10:04:25 INFO - ], 10:04:25 INFO - "revision": "625d8d4ac52e" 10:04:25 INFO - } 10:04:25 INFO - } 10:04:25 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2. 10:04:25 INFO - Running post-action listener: _resource_record_post_action 10:04:25 INFO - ##### 10:04:25 INFO - ##### Running download-and-extract step. 10:04:25 INFO - ##### 10:04:25 INFO - Running pre-action listener: _resource_record_pre_action 10:04:25 INFO - Running main action method: download_and_extract 10:04:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 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 - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/test_packages.json 10:04:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:04:25 INFO - Downloaded 1270 bytes. 10:04:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:04:25 INFO - Using the following test package requirements: 10:04:25 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:04:25 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:04:25 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'jsshell-linux-x86_64.zip'], 10:04:25 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:04:25 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:04:25 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 10:04:25 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 10:04:25 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:04:25 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 10:04:25 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 10:04:25 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:04:25 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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 - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:04:25 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:26 INFO - Downloaded 21580352 bytes. 10:04:26 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:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:04:26 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:27 INFO - Return code: 0 10:04:27 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:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:27 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:04:27 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:28 INFO - Downloaded 21580352 bytes. 10:04:28 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:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 10:04:28 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:29 INFO - Return code: 0 10:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:29 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:04:29 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:32 INFO - Downloaded 11132038 bytes. 10:04:32 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:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 10:04:32 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:32 INFO - Return code: 0 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 - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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:38 INFO - Downloaded 57943508 bytes. 10:04:38 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:38 INFO - mkdir: /builds/slave/test-pgo/properties 10:04:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:04:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:04:38 INFO - Contents: 10:04:38 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2 10:04:38 INFO - Running post-action listener: _resource_record_post_action 10:04:38 INFO - Running post-action listener: set_extra_try_arguments 10:04:38 INFO - ##### 10:04:38 INFO - ##### Running populate-webroot step. 10:04:38 INFO - ##### 10:04:38 INFO - Running pre-action listener: _resource_record_pre_action 10:04:38 INFO - Running main action method: populate_webroot 10:04:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:04:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:04:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:04:38 INFO - '--tppagecycles', 10:04:38 INFO - '7'], 10:04:38 INFO - 'tests': ['tsvgm']}}, 10:04:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:04:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:04:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:04:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:04:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'tests': ['damp', 'tps']}, 10:04:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['damp', 'tps']}, 10:04:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:04:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:04:38 INFO - 'other': {'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'other_l64': {'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'other_nol64': {'tests': ['a11yr', 10:04:38 INFO - 'ts_paint', 10:04:38 INFO - 'tpaint', 10:04:38 INFO - 'sessionrestore', 10:04:38 INFO - 'sessionrestore_no_auto_restore']}, 10:04:38 INFO - 'svgr': {'tests': ['tsvgx', 10:04:38 INFO - 'tsvgr_opacity', 10:04:38 INFO - 'tart', 10:04:38 INFO - 'tscrollx', 10:04:38 INFO - 'cart']}, 10:04:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['tsvgx', 10:04:38 INFO - 'tsvgr_opacity', 10:04:38 INFO - 'tart', 10:04:38 INFO - 'tscrollx', 10:04:38 INFO - 'cart']}, 10:04:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'tests': ['tp5o']}, 10:04:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'talos_options': ['--e10s'], 10:04:38 INFO - 'tests': ['tp5o']}, 10:04:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'talos_options': ['--xperf_path', 10:04:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:38 INFO - 'tests': ['tp5n']}, 10:04:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:04:38 INFO - 'talos_options': ['--e10s', 10:04:38 INFO - '--xperf_path', 10:04:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:04:38 INFO - 'tests': ['tp5n']}}, 10:04:38 INFO - 'talos.zip': {'path': '', 10:04:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:04:38 INFO - Running post-action listener: _resource_record_post_action 10:04:38 INFO - ##### 10:04:38 INFO - ##### Running create-virtualenv step. 10:04:38 INFO - ##### 10:04:38 INFO - Running pre-action listener: _resource_record_pre_action 10:04:38 INFO - Running main action method: create_virtualenv 10:04:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:04:38 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:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:04:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:04:38 INFO - Using real prefix '/usr' 10:04:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:04:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:04:40 INFO - Installing pip.................done. 10:04:40 INFO - Return code: 0 10:04:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:04:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:40 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 10:04:40 INFO - 'HOME': '/home/cltbld', 10:04:40 INFO - 'LANG': 'en_US.UTF-8', 10:04:40 INFO - 'LANGUAGE': 'en_US:en', 10:04:40 INFO - 'LOGNAME': 'cltbld', 10:04:40 INFO - 'MAIL': '/var/mail/cltbld', 10:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:40 INFO - 'MOZ_NO_REMOTE': '1', 10:04:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:40 INFO - 'NO_EM_RESTART': '1', 10:04:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:40 INFO - 'SHELL': '/bin/bash', 10:04:40 INFO - 'SHLVL': '1', 10:04:40 INFO - 'TERM': 'linux', 10:04:40 INFO - 'TMOUT': '86400', 10:04:40 INFO - 'USER': 'cltbld', 10:04:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:40 INFO - '_': '/tools/buildbot/bin/python'} 10:04:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:40 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:40 INFO - Cleaning up... 10:04:40 INFO - Return code: 0 10:04:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:04:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:40 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 10:04:40 INFO - 'HOME': '/home/cltbld', 10:04:40 INFO - 'LANG': 'en_US.UTF-8', 10:04:41 INFO - 'LANGUAGE': 'en_US:en', 10:04:41 INFO - 'LOGNAME': 'cltbld', 10:04:41 INFO - 'MAIL': '/var/mail/cltbld', 10:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:41 INFO - 'MOZ_NO_REMOTE': '1', 10:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:41 INFO - 'NO_EM_RESTART': '1', 10:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:41 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:41 INFO - 'SHELL': '/bin/bash', 10:04:41 INFO - 'SHLVL': '1', 10:04:41 INFO - 'TERM': 'linux', 10:04:41 INFO - 'TMOUT': '86400', 10:04:41 INFO - 'USER': 'cltbld', 10:04:41 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:41 INFO - '_': '/tools/buildbot/bin/python'} 10:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:41 INFO - Downloading/unpacking psutil>=0.7.1 10:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:04:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:43 INFO - Installing collected packages: psutil 10:04:43 INFO - Running setup.py install for psutil 10:04:43 INFO - building 'psutil._psutil_linux' extension 10:04:43 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:43 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:43 INFO - building 'psutil._psutil_posix' extension 10:04:43 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:43 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:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:04:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:04:43 INFO - Successfully installed psutil 10:04:43 INFO - Cleaning up... 10:04:43 INFO - Return code: 0 10:04:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:43 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 10:04:43 INFO - 'HOME': '/home/cltbld', 10:04:43 INFO - 'LANG': 'en_US.UTF-8', 10:04:43 INFO - 'LANGUAGE': 'en_US:en', 10:04:43 INFO - 'LOGNAME': 'cltbld', 10:04:43 INFO - 'MAIL': '/var/mail/cltbld', 10:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:43 INFO - 'MOZ_NO_REMOTE': '1', 10:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:43 INFO - 'NO_EM_RESTART': '1', 10:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:43 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:43 INFO - 'SHELL': '/bin/bash', 10:04:43 INFO - 'SHLVL': '1', 10:04:43 INFO - 'TERM': 'linux', 10:04:43 INFO - 'TMOUT': '86400', 10:04:43 INFO - 'USER': 'cltbld', 10:04:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:43 INFO - '_': '/tools/buildbot/bin/python'} 10:04:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:04:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:45 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:45 INFO - Installing collected packages: mozsystemmonitor 10:04:45 INFO - Running setup.py install for mozsystemmonitor 10:04:45 INFO - Successfully installed mozsystemmonitor 10:04:45 INFO - Cleaning up... 10:04:45 INFO - Return code: 0 10:04:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:04:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:04:45 INFO - Using env: {'DISPLAY': ':0', 10:04:45 INFO - 'HOME': '/home/cltbld', 10:04:45 INFO - 'LANG': 'en_US.UTF-8', 10:04:45 INFO - 'LANGUAGE': 'en_US:en', 10:04:45 INFO - 'LOGNAME': 'cltbld', 10:04:45 INFO - 'MAIL': '/var/mail/cltbld', 10:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:45 INFO - 'MOZ_NO_REMOTE': '1', 10:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:45 INFO - 'NO_EM_RESTART': '1', 10:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:45 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:45 INFO - 'SHELL': '/bin/bash', 10:04:45 INFO - 'SHLVL': '1', 10:04:45 INFO - 'TERM': 'linux', 10:04:45 INFO - 'TMOUT': '86400', 10:04:45 INFO - 'USER': 'cltbld', 10:04:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:45 INFO - '_': '/tools/buildbot/bin/python'} 10:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:46 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:46 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:46 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:46 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:46 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:46 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:47 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:04:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:48 INFO - Downloading docopt-0.6.1.tar.gz 10:04:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:48 INFO - Running setup.py install for blobuploader 10:04:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:48 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:04:48 INFO - Running setup.py install for requests 10:04:48 INFO - Running setup.py install for docopt 10:04:49 INFO - Successfully installed blobuploader requests docopt 10:04:49 INFO - Cleaning up... 10:04:49 INFO - Return code: 0 10:04:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:04:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:49 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 10:04:49 INFO - 'HOME': '/home/cltbld', 10:04:49 INFO - 'LANG': 'en_US.UTF-8', 10:04:49 INFO - 'LANGUAGE': 'en_US:en', 10:04:49 INFO - 'LOGNAME': 'cltbld', 10:04:49 INFO - 'MAIL': '/var/mail/cltbld', 10:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:49 INFO - 'MOZ_NO_REMOTE': '1', 10:04:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:49 INFO - 'NO_EM_RESTART': '1', 10:04:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:49 INFO - 'SHELL': '/bin/bash', 10:04:49 INFO - 'SHLVL': '1', 10:04:49 INFO - 'TERM': 'linux', 10:04:49 INFO - 'TMOUT': '86400', 10:04:49 INFO - 'USER': 'cltbld', 10:04:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:49 INFO - '_': '/tools/buildbot/bin/python'} 10:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:49 INFO - Running setup.py (path:/tmp/pip-4ANjv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:49 INFO - Running setup.py (path:/tmp/pip-8F7EVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:49 INFO - Running setup.py (path:/tmp/pip-9l4Ybs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:49 INFO - Running setup.py (path:/tmp/pip-SFd93K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:49 INFO - Running setup.py (path:/tmp/pip-oqTHA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:49 INFO - Running setup.py (path:/tmp/pip-9MjQKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:49 INFO - Running setup.py (path:/tmp/pip-Sbalxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:49 INFO - Running setup.py (path:/tmp/pip-YRrbGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:49 INFO - Running setup.py (path:/tmp/pip-FOIsNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:50 INFO - Running setup.py (path:/tmp/pip-Ilmg2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:50 INFO - Running setup.py (path:/tmp/pip-2znpNL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:50 INFO - Running setup.py (path:/tmp/pip-a_AEdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:50 INFO - Running setup.py (path:/tmp/pip-Bo2GIl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:50 INFO - Running setup.py (path:/tmp/pip-WJbf2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:50 INFO - Running setup.py (path:/tmp/pip-emw2Br-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:50 INFO - Running setup.py (path:/tmp/pip-uO1aP5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:50 INFO - Running setup.py (path:/tmp/pip-gbwXPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:50 INFO - Running setup.py install for manifestparser 10:04:50 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:04:50 INFO - Running setup.py install for mozcrash 10:04:50 INFO - Running setup.py install for mozdebug 10:04:50 INFO - Running setup.py install for mozdevice 10:04:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:04:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozfile 10:04:51 INFO - Running setup.py install for mozhttpd 10:04:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozinfo 10:04:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozInstall 10:04:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozleak 10:04:51 INFO - Running setup.py install for mozlog 10:04:51 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for moznetwork 10:04:51 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozprocess 10:04:51 INFO - Running setup.py install for mozprofile 10:04:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:04:51 INFO - Running setup.py install for mozrunner 10:04:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:04:52 INFO - Running setup.py install for mozscreenshot 10:04:52 INFO - Running setup.py install for moztest 10:04:52 INFO - Running setup.py install for mozversion 10:04:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:04:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:52 INFO - Cleaning up... 10:04:52 INFO - Return code: 0 10:04:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:52 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 10:04:52 INFO - 'HOME': '/home/cltbld', 10:04:52 INFO - 'LANG': 'en_US.UTF-8', 10:04:52 INFO - 'LANGUAGE': 'en_US:en', 10:04:52 INFO - 'LOGNAME': 'cltbld', 10:04:52 INFO - 'MAIL': '/var/mail/cltbld', 10:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:52 INFO - 'MOZ_NO_REMOTE': '1', 10:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:52 INFO - 'NO_EM_RESTART': '1', 10:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:52 INFO - 'SHELL': '/bin/bash', 10:04:52 INFO - 'SHLVL': '1', 10:04:52 INFO - 'TERM': 'linux', 10:04:52 INFO - 'TMOUT': '86400', 10:04:52 INFO - 'USER': 'cltbld', 10:04:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:52 INFO - '_': '/tools/buildbot/bin/python'} 10:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:52 INFO - Running setup.py (path:/tmp/pip-AcDvcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:04:52 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:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:52 INFO - Running setup.py (path:/tmp/pip-uORKuQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:04:52 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:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:52 INFO - Running setup.py (path:/tmp/pip-kqNS6h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:04:52 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:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:52 INFO - Running setup.py (path:/tmp/pip-vwUkSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:04:52 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:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:52 INFO - Running setup.py (path:/tmp/pip-5H7ddj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:04:52 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:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:52 INFO - Running setup.py (path:/tmp/pip-snNUZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:53 INFO - Running setup.py (path:/tmp/pip-zYb0mf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:53 INFO - Running setup.py (path:/tmp/pip-QcvUrA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:53 INFO - Running setup.py (path:/tmp/pip-lwAiuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:53 INFO - Running setup.py (path:/tmp/pip-_ZuUJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:53 INFO - Running setup.py (path:/tmp/pip-LSsjaA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:53 INFO - Running setup.py (path:/tmp/pip-eTZo7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:53 INFO - Running setup.py (path:/tmp/pip-vbg42F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:53 INFO - Running setup.py (path:/tmp/pip-XUVgof-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:53 INFO - Running setup.py (path:/tmp/pip-t2yhaR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:53 INFO - Running setup.py (path:/tmp/pip-1Dm6tO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:04:53 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:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:53 INFO - Running setup.py (path:/tmp/pip-tIM4OY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:04:53 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:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:55 INFO - Downloading blessings-1.6.tar.gz 10:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:55 INFO - Installing collected packages: blessings 10:04:55 INFO - Running setup.py install for blessings 10:04:55 INFO - Successfully installed blessings 10:04:55 INFO - Cleaning up... 10:04:55 INFO - Return code: 0 10:04:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:04:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:04:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:04:56 INFO - Reading from file tmpfile_stdout 10:04:56 INFO - Current package versions: 10:04:56 INFO - argparse == 1.2.1 10:04:56 INFO - blessings == 1.6 10:04:56 INFO - blobuploader == 1.2.4 10:04:56 INFO - docopt == 0.6.1 10:04:56 INFO - manifestparser == 1.1 10:04:56 INFO - mozInstall == 1.12 10:04:56 INFO - mozcrash == 0.16 10:04:56 INFO - mozdebug == 0.1 10:04:56 INFO - mozdevice == 0.47 10:04:56 INFO - mozfile == 1.2 10:04:56 INFO - mozhttpd == 0.7 10:04:56 INFO - mozinfo == 0.9 10:04:56 INFO - mozleak == 0.1 10:04:56 INFO - mozlog == 3.1 10:04:56 INFO - moznetwork == 0.27 10:04:56 INFO - mozprocess == 0.22 10:04:56 INFO - mozprofile == 0.27 10:04:56 INFO - mozrunner == 6.11 10:04:56 INFO - mozscreenshot == 0.1 10:04:56 INFO - mozsystemmonitor == 0.0 10:04:56 INFO - moztest == 0.7 10:04:56 INFO - mozversion == 1.4 10:04:56 INFO - psutil == 3.1.1 10:04:56 INFO - requests == 1.2.3 10:04:56 INFO - wsgiref == 0.1.2 10:04:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:04:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 10:04:56 INFO - 'HOME': '/home/cltbld', 10:04:56 INFO - 'LANG': 'en_US.UTF-8', 10:04:56 INFO - 'LANGUAGE': 'en_US:en', 10:04:56 INFO - 'LOGNAME': 'cltbld', 10:04:56 INFO - 'MAIL': '/var/mail/cltbld', 10:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:56 INFO - 'MOZ_NO_REMOTE': '1', 10:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:56 INFO - 'NO_EM_RESTART': '1', 10:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:56 INFO - 'SHELL': '/bin/bash', 10:04:56 INFO - 'SHLVL': '1', 10:04:56 INFO - 'TERM': 'linux', 10:04:56 INFO - 'TMOUT': '86400', 10:04:56 INFO - 'USER': 'cltbld', 10:04:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:56 INFO - '_': '/tools/buildbot/bin/python'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Cleaning up... 10:04:56 INFO - Return code: 0 10:04:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:04:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:56 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 10:04:56 INFO - 'HOME': '/home/cltbld', 10:04:56 INFO - 'LANG': 'en_US.UTF-8', 10:04:56 INFO - 'LANGUAGE': 'en_US:en', 10:04:56 INFO - 'LOGNAME': 'cltbld', 10:04:56 INFO - 'MAIL': '/var/mail/cltbld', 10:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:56 INFO - 'MOZ_NO_REMOTE': '1', 10:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:56 INFO - 'NO_EM_RESTART': '1', 10:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:56 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:56 INFO - 'SHELL': '/bin/bash', 10:04:56 INFO - 'SHLVL': '1', 10:04:56 INFO - 'TERM': 'linux', 10:04:56 INFO - 'TMOUT': '86400', 10:04:56 INFO - 'USER': 'cltbld', 10:04:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:56 INFO - '_': '/tools/buildbot/bin/python'} 10:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:56 INFO - Downloading/unpacking jsonschema 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:58 INFO - Downloading/unpacking functools32 (from jsonschema) 10:04:58 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:58 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:58 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:58 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:58 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:58 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:58 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:58 INFO - warning: no files found matching '*.txt' 10:04:58 INFO - no previously-included directories found matching 'build' 10:04:58 INFO - no previously-included directories found matching 'dist' 10:04:58 INFO - no previously-included directories found matching '.git*' 10:04:58 INFO - Installing collected packages: jsonschema, functools32 10:04:58 INFO - Running setup.py install for functools32 10:04:58 INFO - warning: no files found matching '*.txt' 10:04:58 INFO - no previously-included directories found matching 'build' 10:04:58 INFO - no previously-included directories found matching 'dist' 10:04:58 INFO - no previously-included directories found matching '.git*' 10:04:58 INFO - Successfully installed jsonschema functools32 10:04:58 INFO - Cleaning up... 10:04:58 INFO - Return code: 0 10:04:58 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:58 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 0x7ffde5009f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135f0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', '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:58 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:58 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:58 INFO - Using env: {'DISPLAY': ':0', 10:04:58 INFO - 'HOME': '/home/cltbld', 10:04:58 INFO - 'LANG': 'en_US.UTF-8', 10:04:58 INFO - 'LANGUAGE': 'en_US:en', 10:04:58 INFO - 'LOGNAME': 'cltbld', 10:04:58 INFO - 'MAIL': '/var/mail/cltbld', 10:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:58 INFO - 'MOZ_NO_REMOTE': '1', 10:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:58 INFO - 'NO_EM_RESTART': '1', 10:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:04:58 INFO - 'PWD': '/builds/slave/test-pgo', 10:04:58 INFO - 'SHELL': '/bin/bash', 10:04:58 INFO - 'SHLVL': '1', 10:04:58 INFO - 'TERM': 'linux', 10:04:58 INFO - 'TMOUT': '86400', 10:04:58 INFO - 'USER': 'cltbld', 10:04:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:58 INFO - '_': '/tools/buildbot/bin/python'} 10:04:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:58 INFO - Downloading/unpacking flake8 10:04:58 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:58 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:58 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:58 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:58 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:58 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:05:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:05:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:05:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:05:01 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:05:01 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:05:01 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:05:01 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:05:01 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:05:01 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:05:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:01 INFO - no previously-included directories found matching 'docs/_build' 10:05:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:05:01 INFO - Running setup.py install for pep8 10:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:05:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:05:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:05:01 INFO - no previously-included directories found matching 'docs/_build' 10:05:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:05:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:05:01 INFO - Cleaning up... 10:05:01 INFO - Return code: 0 10:05:01 INFO - Running post-action listener: _resource_record_post_action 10:05:01 INFO - Running post-action listener: _start_resource_monitoring 10:05:01 INFO - Starting resource monitoring. 10:05:01 INFO - ##### 10:05:01 INFO - ##### Running install step. 10:05:01 INFO - ##### 10:05:01 INFO - Running pre-action listener: _resource_record_pre_action 10:05:01 INFO - Running main action method: install 10:05:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:05:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Detecting whether we're running mozinstall >=1.0... 10:05:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:05:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:05:01 INFO - Reading from file tmpfile_stdout 10:05:01 INFO - Output received: 10:05:01 INFO - Usage: mozinstall [options] installer 10:05:01 INFO - Options: 10:05:01 INFO - -h, --help show this help message and exit 10:05:01 INFO - -d DEST, --destination=DEST 10:05:01 INFO - Directory to install application into. [default: 10:05:01 INFO - "/builds/slave/test-pgo"] 10:05:01 INFO - --app=APP Application being installed. [default: firefox] 10:05:01 INFO - mkdir: /builds/slave/test-pgo/build/application 10:05:01 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:05:01 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:05:16 INFO - Reading from file tmpfile_stdout 10:05:16 INFO - Output received: 10:05:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:05:16 INFO - Running post-action listener: _resource_record_post_action 10:05:16 INFO - ##### 10:05:16 INFO - ##### Running run-tests step. 10:05:16 INFO - ##### 10:05:16 INFO - Running pre-action listener: _resource_record_pre_action 10:05:16 INFO - Running main action method: run_tests 10:05:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:05:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:05:16 INFO - Python 2.7.3 10:05:16 INFO - Return code: 0 10:05:16 INFO - grabbing minidump binary from tooltool 10:05: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:05:16 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 0x13ede30>, '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 0x13eed30>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13ef1c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:05:16 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:05:16 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:05:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:05:16 INFO - Return code: 0 10:05:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:05:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:05:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:05:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:05:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:05:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:05:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:05:17 INFO - Return code: 0 10:05:17 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/1454513789/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 10:05:17 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/1454513789/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 10:05:17 INFO - Using env: {'DISPLAY': ':0', 10:05:17 INFO - 'HOME': '/home/cltbld', 10:05:17 INFO - 'LANG': 'en_US.UTF-8', 10:05:17 INFO - 'LANGUAGE': 'en_US:en', 10:05:17 INFO - 'LOGNAME': 'cltbld', 10:05:17 INFO - 'MAIL': '/var/mail/cltbld', 10:05:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:05:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:05:17 INFO - 'MOZ_NO_REMOTE': '1', 10:05:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:05:17 INFO - 'NO_EM_RESTART': '1', 10:05:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:05:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:05:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:05:17 INFO - 'SHELL': '/bin/bash', 10:05:17 INFO - 'SHLVL': '1', 10:05:17 INFO - 'TERM': 'linux', 10:05:17 INFO - 'TMOUT': '86400', 10:05:17 INFO - 'USER': 'cltbld', 10:05:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555', 10:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:05:17 INFO - '_': '/tools/buildbot/bin/python'} 10:05:17 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/1454513789/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 10:05:17 INFO - mozversion INFO | application_buildid: 20160203073629 10:05:17 INFO - mozversion INFO | application_changeset: 625d8d4ac52ea7b123589ff4eb1be3d94f417554 10:05:17 INFO - mozversion INFO | application_display_name: Nightly 10:05:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:05:17 INFO - mozversion INFO | application_name: Firefox 10:05:17 INFO - mozversion INFO | application_remotingname: firefox 10:05:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:17 INFO - mozversion INFO | application_vendor: Mozilla 10:05:17 INFO - mozversion INFO | application_version: 45.0 10:05:17 INFO - mozversion INFO | platform_buildid: 20160203073629 10:05:17 INFO - mozversion INFO | platform_changeset: 625d8d4ac52ea7b123589ff4eb1be3d94f417554 10:05:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:05:17 INFO - mozversion INFO | platform_version: 45.0 10:05:17 INFO - 2016-02-03 10:05:17,826 DEBUG : using testdate: 1454522717 10:05:17 INFO - 2016-02-03 10:05:17,826 DEBUG : actual date: 1454522717 10:05:17 INFO - 2016-02-03 10:05:17,835 INFO : starting webserver on 'localhost:39533' 10:05:17 INFO - 2016-02-03 10:05:17,836 INFO : Starting test suite talos-linux64-ix-019 10:05:17 INFO - 2016-02-03 10:05:17,836 INFO : Starting test dromaeo_css 10:05:17 INFO - 2016-02-03 10:05:17,836 DEBUG : operating with platform_type : linux_ 10:05:17 INFO - 2016-02-03 10:05:17,837 INFO : Initialising browser for dromaeo_css test... 10:05:17 INFO - 2016-02-03 10:05:17,852 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMpV0Dz/profile http://localhost:39533/getInfo.html 10:05:21 INFO - 2016-02-03 10:05:21,862 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:21 INFO - 2016-02-03 10:05:21,862 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:21 INFO - 2016-02-03 10:05:21,862 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:21 INFO - 2016-02-03 10:05:21,862 DEBUG : BROWSER_OUTPUT: __metrics 10:05:22 INFO - 2016-02-03 10:05:22,044 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:05:23 INFO - 2016-02-03 10:05:23,071 INFO : Browser initialized. 10:05:23 INFO - 2016-02-03 10:05:23,072 INFO : Running cycle 1/1 for dromaeo_css test... 10:05:23 INFO - 2016-02-03 10:05:23,072 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMpV0Dz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:34 INFO - 2016-02-03 10:05:34,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 134127616 10:05:34 INFO - 2016-02-03 10:05:34,779 DEBUG : BROWSER_OUTPUT: 10:06:25 INFO - 2016-02-03 10:06:25,736 DEBUG : BROWSER_OUTPUT: 1454522785732 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:34 INFO - 2016-02-03 10:08:34,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39533/tests/dromaeo/cssquery-ext.html) 10:08:35 INFO - 2016-02-03 10:08:35,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 217288704 10:08:35 INFO - 2016-02-03 10:08:35,145 DEBUG : BROWSER_OUTPUT: 10:11:37 INFO - 2016-02-03 10:11:37,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-ext.html (next: http://localhost:39533/tests/dromaeo/cssquery-jquery.html) 10:11:37 INFO - 2016-02-03 10:11:37,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 216965120 10:11:37 INFO - 2016-02-03 10:11:37,772 DEBUG : BROWSER_OUTPUT: 10:14:39 INFO - 2016-02-03 10:14:39,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39533/tests/dromaeo/cssquery-mootools.html) 10:14:40 INFO - 2016-02-03 10:14:40,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 214552576 10:14:40 INFO - 2016-02-03 10:14:40,042 DEBUG : BROWSER_OUTPUT: 10:17:41 INFO - 2016-02-03 10:17:41,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39533/tests/dromaeo/cssquery-prototype.html) 10:17:42 INFO - 2016-02-03 10:17:42,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 210771968 10:17:42 INFO - 2016-02-03 10:17:42,351 DEBUG : BROWSER_OUTPUT: 10:20:44 INFO - 2016-02-03 10:20:44,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39533/tests/dromaeo/cssquery-yui.html) 10:20:45 INFO - 2016-02-03 10:20:45,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 204136448 10:20:45 INFO - 2016-02-03 10:20:45,294 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/dromaeo/cssquery-yui.html (next: http://localhost:39533/tests/dromaeo/cssquery-dojo.html) 10:23:47 INFO - 2016-02-03 10:23:47,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 246538240 10:23:47 INFO - 2016-02-03 10:23:47,636 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,637 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:23:47 INFO - 2016-02-03 10:23:47,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:23:47 INFO - 2016-02-03 10:23:47,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:23:47 INFO - 2016-02-03 10:23:47,637 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:23:47 INFO - 2016-02-03 10:23:47,639 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3387.474941384085;3452.326796274724;3482.286131343075;3486.1981744198833;3493.336266109439;5742;5747.770089196427;5762.423757624246;5773.3937936516695;5774.451427114428;5753.769849206027;5764.740586673599;5796.536277097833;5797.5651826113;5818.389069147742;5052.368453943257;5230.92153617697;5260.947390526103;5328.600354973373;5353.652012619187;5241.161414173733;5242.344706911636;5248.448912864133;5250.186221135711;5255.264263003163;5108.565771909373;5188.533032027117;5215.113430716788;5216.478352164791;5244.816431424901;5191.558717509016;5289.47105289468;5292.44429334922;5293.338332708411;5296.205569164617;5195.246689230041;5215.139501982168;5225.634205605571;5279.260903473517;5294.629375943686;5376.247325374451;5394.757235924393;5478.068728316196;5488.807891723811;5582.106862901916;6130.601510901777;6154.415330543591;6165.32181460039;6168.167297414881;6172.074188871705;6114.357992410822;6178.289496707891;6193.1329613854095;6194.473469755031;6195.287541932646;5488.615796894219;5598.972005139989;5698.373178950354;5797.88404231913;5825.097109947922;6266.373362663697;6267.2165979252595;6343.048542718537;6343.460805831463;6357.936420635827;5941.316748573883;6099.817005489843;6102.603330783485;6108.053251745987;6108.144859719643;5961.165436838846;6044.395560444008;6046.727897244635;6082.665453400105;6113.29697084841;6029.6683682397015;6129.693515324305;6130.662813545208;6131.049687298476;6132.41742034506;5875.353711091777;6054.152418661391;6130.754769809158;6151.323354431099;6152.600080994811;4585.679002469795;4627.097715945359;4654.813807447732;4656.697314674535;4679.9532004680195;4135.9172816544105;4167.6457501112745;4179.6029377209115;4196.727212731163;4209.368594710818;5619.690916999522;5717.628354156966;5717.914231286534;5798.188253644493;5806.506446952057;6082.200779309964;6238.189035425366;6246.063090536365;6263.906041409383;6267.71795269214;5896.027155519377;5901.203337549462;5924.555658325643;5928.67392293428;5946.583739138218;5193.221016847503;5271.815486457956;5319.308489896289;5351.652142610717;5360.222767698662;6203.410675985774;6225;6240.469560087444;6242.906356404657;6248.375162483806;6014.248218972629;6036.486898613667;6039.094135879654;6039.365866584121;6048.36492168316;6098.853789760313;6104.725287361991;6214.658193799384;6222.751089956351;6393.8721225576155;6089.847753806191;6102.816915492543;6104.38956104386;6135.631862088289;6140.57016008893;6217.409346112112;6232.376762323732;6234.844128896814;6239.282482514569;6242.968785156045;5745.454181852718;5849.94150058494;5949.940500594938;6034.698265086816;6062.302835174011;5804;5949.881002380015;5958.344582096052;5958.910616340671;5963;5671.064274394678;5850.970745146247;5885.882282354414;5892.322382926019;5893.6463812171405;5847;5901.291844978458;5947.375525569752;5976.372480889618;5982.7008649568215;5927.496162826035;5940.702964851654;5950.107483877453;5952.375000624872;5975.37258587842 10:23:47 INFO - 2016-02-03 10:23:47,640 DEBUG : BROWSER_OUTPUT: |1;ext.html;610.2524407600687;611.9204503414555;618.6350053468456;639.5075791640436;639.5938579002334;36343.454848177265;37128.81435592822;37170.81414592927;37242;37331;45192.322115168216;45799.54200457995;45821.54178458214;45828.770856145755;45887;7889.250521200505;8006.959965200195;8012.5593092379895;8917.108289171063;9069.637214511444;10635.415052172128;10862.674119776419;10878.673639790819;10881.183911206692;10884.61903833366;10486.895131048668;10552.208584356165;10587.576496940152;10589.576416943313;10596.152307815395;10587.258891877533;10672.30630009047;10690.679279621623;10697.839532406942;10700.839487407695;10429.843552346721;10550.050495455445;10561.683149505527;10564.049235568758;10565;44205.336919946225;44652;44672.776636116934;44730;44763.328550071776;3200.647928727838;3257.218267615779;3276.2464633134514;3366;4051.169510250421;32152.839235803673;32163.83918080418;32192.83903580467;32422.351552969045;32590.511142332885;3289.687479689426;3362.0922350965348;3362.714169295613;3400.3709313776785;3466.185446420089;298252;302219;302827;303549;304099;56187.71906140443;65660;66443.66778166078;66933.665331674;66990.66504667446;50917.74541127345;73102;74520.62739686266;74587.62706186435;74644.25355746373;18284.451466456027;18389.172487238106;18490.260389584266;18492.630147396976;18513;14006;14058;14085.71828563423;14088.577342679737;14096.788548171786;20773.688394674093;20945.057472413777;20959.68560471594;20963.895180524305;21010.2646407375;7463.925360746323;7482.812929676693;7551.809975107267;7552.924470755332;7636.885446718304;964.1419136968104;976.6923419122953;987.8419452887504;991.1971303244395;1055.5724931402794;29728.256793580334;29836.254093647833;30415.087547373616;30795.538066929013;30941.071767847;995.9751006224902;1038.896110388955;1057.4765491081964;1107.429673718036;1178.8054970929873;13111.672208194681;13545.525906593222;14014.789778153336;16149.434769783002;16212;344511;346205;347187;347247;348493;55141.72429137828;55377.16934245989;55461.1680824788;55643.44356556464;55666.72166639141;1459.1026518690928;1466.7579849324743;1471.4923351443736;1473.3075454536352;1485.4206859324872;26305.605415918395;29319.267018324714;29824.25439364033;30193.09420717382;30871.84564077165;51237.74381128071;51575.48424515857;51584;51593.484065160366;51629.48370516397;264315;264477;265025;265448;265930;30425.543616846207;30649;33765.32469350648;33769.49345759865;34245.31509369848;40110.59889401068;40170;40554.79722601368;41000.384994224514;41675;35919.28161436809;36384.27231455409;36774.44838327374;37103.62896371002;37266.25467490689;37301.81349093237;37695.81152094222;38498;42605;42654.573454266305;36100.27799444049;36562;36936.630633694396;37378.8131059343;37596.436053459765;32630.51054234236;32662.673373265963;32822.835885820416;32982.175445614055;33017.834910826256;25866.61200082038;26486.424447471367;26654.733452665227;26667.599985999837;28173.490652313663 10:23:47 INFO - 2016-02-03 10:23:47,643 DEBUG : BROWSER_OUTPUT: |2;jquery.html;384.4156881540059;386.73508646577113;388.74731424574026;389.4489297643834;392.3154096102301;17049.914750426247;18198.363057292998;18382.90808545957;18507.074646267683;19376.22495100198;18087.18607662655;18229.908850455762;18235;18611.255549778027;18629;5558.610897237195;5719.28508936383;5721.570882183832;5725.198472213893;5732.398098199692;5582.748776305076;5639.887202255953;5664.235328230698;5671.376148623648;5676.063449530822;4326.84856030039;4430.712003719764;5622.184783206432;5626.240457538242;5626.831195064135;6045.546584006195;6196.628202307876;6231.034189700604;6233.438990490855;6237.064440333941;5423.050966080959;5463.371712253102;5465.371482279509;5471.316085489314;5535.059039963216;21979;22023.22918697854;22166.66749998735;22594.435139121488;22657;2216.767239439868;2253.0537174386795;2255.571441426124;2275.4538910661486;2276.965845512302;13532.188068715908;13736.65658358539;13797.172169669751;13982.790258146137;14119.082259653089;1691.4418241980118;1727.1709579401831;1736.4530172995592;1752.8860624059396;1766.3287950578826;66336;67062.9940550892;67565;68425;68799.65600171968;9991.900080999098;10064.043915827984;10101;10238.027387398186;10483.423411712276;13199.736005279841;13217.471301148038;13230;13234.272115033573;13349.199048057148;8028.277455029075;8118.634661440249;8123.634436450374;8441.198086181803;8599.957000215085;8122.147174546588;8151.062627797761;8186.099529051799;8206.261436470626;8238.752837414888;6138.662373569497;6290.654014029273;6402.167718196604;6475.093486911836;6521.543491955517;1765.7527946087557;1776.9289228430976;1833.6516061948187;1869;1910.980890191108;984.3503287829998;1020.3724709303873;1060.7136073260176;1076.7361996310954;1131.332513816852;16275.023498590122;16998.450232465228;17266.309347625953;17321.220545075503;17840.46478605644;834.5576844272424;938.3384713776771;943.6697155995485;958.6213445688913;1085.7177133945074;9454.48000359973;9743.61025558984;9802.411855288563;9867.062629050371;10197.541110650038;441886;524358;618075;620686;624490;83061;85138;86111.56944215365;86393.56803216069;86759;1217.117589747426;1220.8290839282508;1223.406647775828;1232.6671798614325;1242.0932719115096;14937.551873443814;15144.242787860783;15203.923980380026;15286.312115955032;15509.069455832687;37744.62255377411;38242.61757382502;38968.80515597404;39153.804230979804;39657;54414.18378724243;55628.72185639046;58757.41242587519;59064.70467647634;61273;14941.62645933817;15286.464973725866;15300.158491283086;15310.846891531388;15750.76373854416;12342.259464432163;12525.498980040697;12729.172603780724;18883.716744249123;19665.508362291057;10525.315854469434;10565.471726413494;10626.89373106259;10684.358938463716;10735;10895.346279223271;11101.611443599435;11220.270682405617;11388.430578471209;11604.88395116038;9142;9358.859617105885;11041;11306;11788.23376480526;15007.32467038964;15217.619559510658;15218;15376.615584610474;15461.149636770086;15650.9217453912;15795.921020394824;15931.044137351795;16196.595085122966;16259.430919917746 10:23:47 INFO - 2016-02-03 10:23:47,643 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1467.750482417989;1528.3275358842104;1656.6106964863263;1713.5630414244365;1856.7307740377655;7163.35529802319;7282.781516554499;7592.620368981549;7950.36397088233;7963.442559020864;7746.651400686968;7878.094019187795;8015.599220038989;8017.799555011113;8027.839443211133;2386.5107652931106;2426.9029238830426;2430.562498750224;2431.8905649245826;2435.062500937143;2180.1824315881545;2198.934031979043;2208.094681180716;2326.6161083421216;2390.22317746733;2357.1867705641525;2360.5042940982416;2363.5627408929317;2365.4677697518005;2367.8342516023886;2294.804941579968;2326.127702111708;2326.6626339180725;2328.8951997160084;2341.9297421077395;2393.6888204533475;2395.4849707312837;2431.343537244934;2438.146648672968;2443.596806526921;8091.514509129471;8171.18288171184;8187.058488273865;8194.467359621665;8205.179482051806;5019.29729837823;5082.136036873703;5103.260027296058;5151.922721159186;5152.742362881841;3200.247941733691;3218.372417378612;3241.983790081058;3249.171461277359;3283.343331333719;1041.0838462153333;1051.758095638;1065.9467026648636;1071.0681706915034;1083.2363183955292;11383.203175777699;11390.544378224944;11397.772044559146;11411.144164187719;11440.027597654127;4616.192166370872;4641.721496710141;4665.4168228971375;4678.204705200124;4708.340832283483;9805.01949805028;9811.116999470081;9811.26415518839;9815.214782817358;9816.312858099864;5169.431362550116;5176.094183517869;5177.249298851721;5178.197379406198;5202.375714914235;4722.173619616553;4723.385959825269;4726.338312636233;4726.71639701619;4731.455882573479;4060.675145988314;4148.066684995852;4151.97924010384;4176.60322269384;4186.330187170038;1202.0984261803646;1213.1447329632588;1217.7442737025324;1275.5663074554695;1334.8932085433141;1026.2662196529518;1049.2340591368343;1049.7218237167158;1188.3464094747853;1327.0445279398818;7185.425165986709;7240.4569657275915;7275.490715649959;7306.780796576111;7314.634268286564;1141.0716581135878;1147.3173461790223;1147.7302833834042;1148.0413854431476;1150.9021733152777;5371.731413429313;5476.17857321397;5488.7530061147345;5489.451054894558;5493.505584497414;9868;10031.047050530187;10140.935201803852;10323.07092361676;10351.585936562604;10020.599176032876;10159.390436573682;10206.387616743019;10209.897901021044;10212.183025357954;7607.505512141804;7807;7841.451098423056;7857.057153141545;7858.0570331560575;7116.039334689751;7172.031775710212;7212.098487689039;7238.963805181151;7248.565086094851;8792.42849214799;8809.207171354608;8827;9045.77385565366;9063.728088157366;8984.101589840964;9031.277497800029;9128.634854605742;9161.86257206129;9168.862467063132;7498;7562.621868906643;7569.735059272899;7578.12851522082;7580.583067931317;7997.360211183208;8060.15368386311;8098;8112.634931428218;8121.8375632488205;6723.831904202434;7491.662875170521;7509.88735168962;7545.886811697938;7627.618619069135;6836.28219036994;7446.25537446251;7465.29079737424;7509.549427034177;7577.734779282699;7169.211386747349;7186.640667966685;7210.206877243604;7217.927820721936;7222.169450513258;6255.493045865901;6264.655443950626;6309.400606942333;6314.368563143649;6322.241331040304;6473.029045643191;6483.481321494363;6520.608763474207;6532.314107018695;6549.214094308713 10:23:47 INFO - 2016-02-03 10:23:47,645 DEBUG : BROWSER_OUTPUT: |4;prototype.html;367.31129132875856;370.7645645015416;372.073536893136;374.78262607687543;385.12192201779936;6130.417610327017;6148.754049838007;6155.784547540837;6174.228221472316;6238.251409830816;5820.738066786994;5886.146508756238;5909.85225369366;6105.328413874481;6109.847253818646;4709.105269998707;4742.217534106868;4750.073735621547;4758.286257061452;4759.500252473493;4792.83225087122;4800.015996720664;4808.927866081994;4809.5430934061205;4810.639202059842;4515.322701594754;4639.605633521155;4640.79116439761;4729.290606409032;4776.832810851621;4755.476897541268;4756.310335001405;4766.523347665206;4774.73738944358;4778.498257682928;4239.300515414953;4250.574942505756;4251.44731184944;4251.723637963522;4252.510961239466;5701.2018317435595;5759.308882934033;5790.826275211751;5794.5074668653215;5814.069748840166;5579.38626751057;5589.217509548666;5589.245451863987;5593.468620481048;5600.243967064435;6509.3490650935;6510.18622672166;6518.739250429977;6522.412982831568;6524.706388212494;4718.05638872227;4725.76371181443;4726.149293127236;4727.149113159629;4739.241721324606;6602.3067577904585;6760.628165450898;6762.087118239024;6778.627175505345;6780.627065511395;4851.2723091535845;4851.708897466164;4851.902961940812;4856.125897338442;4857.805687772449;4913.70517768935;4916.434610019822;4917.606591472673;4919.7540122993705;4922.827701030446;5459.372172200247;5565.30433695788;5576.219329293902;5577.135543990688;5578.107502799533;6538.934610653928;6544.411003009752;6546.214454265423;6546.574472659262;6548.6725663716625;1715.2795825753215;1736.9925443243142;1740.5822602575545;1740.85202757767;1741.0250259854522;1172.284906207213;1202.1164444133556;1202.7955247607927;1212.5271144253747;1230.366361323919;6395.296517383084;6400.97584386496;6405.263394709668;6409.807705768834;6411.294757576663;6761.154855643044;6764.323567643295;6768.830779230559;6769.72921083161;6773.830654233683;6212.72042758077;6260.186175797208;6370.203724534434;6470.352964703492;6476.384743449365;3645.76302540334;3670.4127339625534;3677.154254521475;3678.576963649161;3681.116532032293;6947.096877405905;6973.302669733088;6975.581465112109;6986.301369862973;6992.16094068715;6805.557638753465;7023.086998690138;7034.6482675866;7043.049188359609;7045.92954070463;7025.192102908231;7028.156621205488;7030.472714546429;7030.789076327718;7032.648367581601;6551.181102362205;6777.728890844311;6797.762078327235;6847.452203823782;6858.691358888762;6564.934350656432;6675.532712710258;6716.764913228014;6719.496037797087;6741.59550426976;6994.370506654425;6995.580265184105;7000.50996430245;7001.334873187039;7006.124234470692;4636.397268355092;4638.536146385334;4711.9293210602555;4713.151632706009;4713.62291016711;6816.488763342868;6820.147481564804;6829.590224586541;6832.760853370307;6840.692168852314;6628.469722422291;6635.9004614929845;6636.668166591748;6640.435562977201;6644.970029645413;6518.120053792677;6614.10709554204;6630.138082049302;6631.0716499689115;6642.867142657216;6449.097126402214;6476.6114033158165;6480.837979050561;6483.578567393104;6490.188726409199;6615.569987950767;6643.634600097041;6659.334066593302;6663.433608143362;6665;6397.200349956255;6466.094746735367;6492.091107245084;6502.187226596676;6517.185351831021 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: |5;yui.html;685.6023506366308;725.5066554742776;787.2442455242966;864.5417928497899;869.7390782765173;12884.613461596144;13281.203127812338;13323.200607963518;13377.197368157917;13381.130226535268;12565.623031309075;12769.23384596925;12799.872001279984;12815.167014144097;12820.230786152837;616.2143267334162;621.4313902778974;878.5958459108801;901.085398320705;916.7662246127228;906.650939388337;910.5401772105077;912.9726108216731;914.4239129348534;914.5335878701877;799.3046049936535;960.6493629825134;968.2254196642693;970.9660161894335;972.4408465132542;805.9194080591923;937.3625934364629;950.1686024728363;952.295301476909;952.3666761603525;703.4583370804503;704.6441547018774;705.4497491956282;706.3995603736834;706.8197609609516;12487.625371238877;12723.872761272454;12755.362231888368;12758.170718903242;12774.105812593029;11969;12819.446095328687;13022.088453808143;13052.34738263083;13168.670783230496;9512.191463725592;9835.803283934281;9864.062914023156;9873.308868379216;9919.702408927744;3480.89557313281;3505.4216054351;3523.541939547868;3528.7706299090733;3532.5760908691122;50182.749086254335;50666.24000639993;50837.49162508402;51222.23166652503;51300.97398052055;9168.495732734631;9302.86045709315;9379.624815007322;9385.155336019654;9419.90580094204;18720.812791871907;18860.339888103852;18872.81127188738;18899.527511812314;18909.52726181829;7253;7299.671514781848;7378.520396174232;7390.408767298603;7458.627068646546;4297.39836422901;4397.714148580332;4453.933191002137;4498.145352383037;4516.412866327357;3437.98579419072;3476.443768996999;3478.4956181353564;3482.355764183634;3482.7562070655317;568.6218664588085;592.4342253148233;602.8583282928508;607.9118527813442;609.1046162141645;577.6851615869361;580.8334910782804;586.4077281945181;606.6390497653889;623.9032949892774;8303.584820759059;8388.538630375266;8602.096779838152;8639.13608639131;8731.825363492695;632.8797528469668;640.1805688718448;642.408983734965;695.3741632530662;722.2380388689983;3966.742161759534;3979.801009949491;4127.360259159835;4265.765382903908;4345.3699213613845;53295.20057199145;53466.465335346926;54672.45327546753;61794;62231;54025.459745402826;54851.451485485435;55318.44681553214;55521;55590.72204639032;49209.753951230734;50283;50420.49579504231;50749;51175;8254.628541715758;8289.212524810133;8580.613872375883;8608.053114157563;8669.783255418664;36881.262374751816;37662;38018.2396352077;38814;39513.60486395214;48371.27443088286;50085;50722;51295.74352128216;52507;10652.147828173882;11080.501377438195;11146.386948717898;11148.944255278671;11746.35395053246;11297.43512824339;12234.571789987307;12291.75416491683;12443.813342799684;12958.013837200364;10679.839802403125;10747.086497647475;10772.838407423738;11154.219204655596;11438.37088960082;10528.420936848546;10735.838962415413;10817.1346292298;11150.442477875911;11271.943640281746;10257.794844103226;10691.679249622524;10829.458527073457;10845.349279043283;10952.780944381228;9158.95420522893;9253.953730231306;9327.533623318943;9484.383515071499;9727.951360243154;9061.093890610886;9321.254299656146;9396.77085882364;9557.235421166151;9589.232861371212 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,756 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: __startTimestamp1454523827636__endTimestamp 10:23:47 INFO - 2016-02-03 10:23:47,646 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,647 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:23:47 INFO - 2016-02-03 10:23:47,647 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:23:47 INFO - 2016-02-03 10:23:47,647 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,647 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5687.70 Median:5901.29 stddev:627.23 (10.6%) stddev-sans-first:602.64 10:23:47 INFO - 2016-02-03 10:23:47,648 DEBUG : BROWSER_OUTPUT: Values: 3387.5 3452.3 3482.3 3486.2 3493.3 5742.0 5747.8 5762.4 5773.4 5774.5 5753.8 5764.7 5796.5 5797.6 5818.4 5052.4 5230.9 5260.9 5328.6 5353.7 5241.2 5242.3 5248.4 5250.2 5255.3 5108.6 5188.5 5215.1 5216.5 5244.8 5191.6 5289.5 5292.4 5293.3 5296.2 5195.2 5215.1 5225.6 5279.3 5294.6 5376.2 5394.8 5478.1 5488.8 5582.1 6130.6 6154.4 6165.3 6168.2 6172.1 6114.4 6178.3 6193.1 6194.5 6195.3 5488.6 5599.0 5698.4 5797.9 5825.1 6266.4 6267.2 6343.0 6343.5 6357.9 5941.3 6099.8 6102.6 6108.1 6108.1 5961.2 6044.4 6046.7 6082.7 6113.3 6029.7 6129.7 6130.7 6131.0 6132.4 5875.4 6054.2 6130.8 6151.3 6152.6 4585.7 4627.1 4654.8 4656.7 4680.0 4135.9 4167.6 4179.6 4196.7 4209.4 5619.7 5717.6 5717.9 5798.2 5806.5 6082.2 6238.2 6246.1 6263.9 6267.7 5896.0 5901.2 5924.6 5928.7 5946.6 5193.2 5271.8 5319.3 5351.7 5360.2 6203.4 6225.0 6240.5 6242.9 6248.4 6014.2 6036.5 6039.1 6039.4 6048.4 6098.9 6104.7 6214.7 6222.8 6393.9 6089.8 6102.8 6104.4 6135.6 6140.6 6217.4 6232.4 6234.8 6239.3 6243.0 5745.5 5849.9 5949.9 6034.7 6062.3 5804.0 5949.9 5958.3 5958.9 5963.0 5671.1 5851.0 5885.9 5892.3 5893.6 5847.0 5901.3 5947.4 5976.4 5982.7 5927.5 5940.7 5950.1 5952.4 5975.4 10:23:47 INFO - 2016-02-03 10:23:47,648 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,648 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48832.90 Median:18189.96 stddev:80093.55 (440.3%) stddev-sans-first:80236.39 10:23:47 INFO - 2016-02-03 10:23:47,648 DEBUG : BROWSER_OUTPUT: Values: 610.3 611.9 618.6 639.5 639.6 36343.5 37128.8 37170.8 37242.0 37331.0 45192.3 45799.5 45821.5 45828.8 45887.0 7889.3 8007.0 8012.6 8917.1 9069.6 10635.4 10862.7 10878.7 10881.2 10884.6 10486.9 10552.2 10587.6 10589.6 10596.2 10587.3 10672.3 10690.7 10697.8 10700.8 10429.8 10550.1 10561.7 10564.0 10565.0 44205.3 44652.0 44672.8 44730.0 44763.3 3200.6 3257.2 3276.2 3366.0 4051.2 32152.8 32163.8 32192.8 32422.4 32590.5 3289.7 3362.1 3362.7 3400.4 3466.2 298252.0 302219.0 302827.0 303549.0 304099.0 56187.7 65660.0 66443.7 66933.7 66990.7 50917.7 73102.0 74520.6 74587.6 74644.3 18284.5 18389.2 18490.3 18492.6 18513.0 14006.0 14058.0 14085.7 14088.6 14096.8 20773.7 20945.1 20959.7 20963.9 21010.3 7463.9 7482.8 7551.8 7552.9 7636.9 964.1 976.7 987.8 991.2 1055.6 29728.3 29836.3 30415.1 30795.5 30941.1 996.0 1038.9 1057.5 1107.4 1178.8 13111.7 13545.5 14014.8 16149.4 16212.0 344511.0 346205.0 347187.0 347247.0 348493.0 55141.7 55377.2 55461.2 55643.4 55666.7 1459.1 1466.8 1471.5 1473.3 1485.4 26305.6 29319.3 29824.3 30193.1 30871.8 51237.7 51575.5 51584.0 51593.5 51629.5 264315.0 264477.0 265025.0 265448.0 265930.0 30425.5 30649.0 33765.3 33769.5 34245.3 40110.6 40170.0 40554.8 41000.4 41675.0 35919.3 36384.3 36774.4 37103.6 37266.3 37301.8 37695.8 38498.0 42605.0 42654.6 36100.3 36562.0 36936.6 37378.8 37596.4 32630.5 32662.7 32822.8 32982.2 33017.8 25866.6 26486.4 26654.7 26667.6 28173.5 10:23:47 INFO - 2016-02-03 10:23:47,649 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,649 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30792.38 Median:12191.72 stddev:93358.70 (765.8%) stddev-sans-first:93592.68 10:23:47 INFO - 2016-02-03 10:23:47,650 DEBUG : BROWSER_OUTPUT: Values: 384.4 386.7 388.7 389.4 392.3 17049.9 18198.4 18382.9 18507.1 19376.2 18087.2 18229.9 18235.0 18611.3 18629.0 5558.6 5719.3 5721.6 5725.2 5732.4 5582.7 5639.9 5664.2 5671.4 5676.1 4326.8 4430.7 5622.2 5626.2 5626.8 6045.5 6196.6 6231.0 6233.4 6237.1 5423.1 5463.4 5465.4 5471.3 5535.1 21979.0 22023.2 22166.7 22594.4 22657.0 2216.8 2253.1 2255.6 2275.5 2277.0 13532.2 13736.7 13797.2 13982.8 14119.1 1691.4 1727.2 1736.5 1752.9 1766.3 66336.0 67063.0 67565.0 68425.0 68799.7 9991.9 10064.0 10101.0 10238.0 10483.4 13199.7 13217.5 13230.0 13234.3 13349.2 8028.3 8118.6 8123.6 8441.2 8600.0 8122.1 8151.1 8186.1 8206.3 8238.8 6138.7 6290.7 6402.2 6475.1 6521.5 1765.8 1776.9 1833.7 1869.0 1911.0 984.4 1020.4 1060.7 1076.7 1131.3 16275.0 16998.5 17266.3 17321.2 17840.5 834.6 938.3 943.7 958.6 1085.7 9454.5 9743.6 9802.4 9867.1 10197.5 441886.0 524358.0 618075.0 620686.0 624490.0 83061.0 85138.0 86111.6 86393.6 86759.0 1217.1 1220.8 1223.4 1232.7 1242.1 14937.6 15144.2 15203.9 15286.3 15509.1 37744.6 38242.6 38968.8 39153.8 39657.0 54414.2 55628.7 58757.4 59064.7 61273.0 14941.6 15286.5 15300.2 15310.8 15750.8 12342.3 12525.5 12729.2 18883.7 19665.5 10525.3 10565.5 10626.9 10684.4 10735.0 10895.3 11101.6 11220.3 11388.4 11604.9 9142.0 9358.9 11041.0 11306.0 11788.2 15007.3 15217.6 15218.0 15376.6 15461.1 15650.9 15795.9 15931.0 16196.6 16259.4 10:23:47 INFO - 2016-02-03 10:23:47,650 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,650 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5733.48 Median:5176.67 stddev:2987.30 (57.7%) stddev-sans-first:2978.47 10:23:47 INFO - 2016-02-03 10:23:47,650 DEBUG : BROWSER_OUTPUT: Values: 1467.8 1528.3 1656.6 1713.6 1856.7 7163.4 7282.8 7592.6 7950.4 7963.4 7746.7 7878.1 8015.6 8017.8 8027.8 2386.5 2426.9 2430.6 2431.9 2435.1 2180.2 2198.9 2208.1 2326.6 2390.2 2357.2 2360.5 2363.6 2365.5 2367.8 2294.8 2326.1 2326.7 2328.9 2341.9 2393.7 2395.5 2431.3 2438.1 2443.6 8091.5 8171.2 8187.1 8194.5 8205.2 5019.3 5082.1 5103.3 5151.9 5152.7 3200.2 3218.4 3242.0 3249.2 3283.3 1041.1 1051.8 1065.9 1071.1 1083.2 11383.2 11390.5 11397.8 11411.1 11440.0 4616.2 4641.7 4665.4 4678.2 4708.3 9805.0 9811.1 9811.3 9815.2 9816.3 5169.4 5176.1 5177.2 5178.2 5202.4 4722.2 4723.4 4726.3 4726.7 4731.5 4060.7 4148.1 4152.0 4176.6 4186.3 1202.1 1213.1 1217.7 1275.6 1334.9 1026.3 1049.2 1049.7 1188.3 1327.0 7185.4 7240.5 7275.5 7306.8 7314.6 1141.1 1147.3 1147.7 1148.0 1150.9 5371.7 5476.2 5488.8 5489.5 5493.5 9868.0 10031.0 10140.9 10323.1 10351.6 10020.6 10159.4 10206.4 10209.9 10212.2 7607.5 7807.0 7841.5 7857.1 7858.1 7116.0 7172.0 7212.1 7239.0 7248.6 8792.4 8809.2 8827.0 9045.8 9063.7 8984.1 9031.3 9128.6 9161.9 9168.9 7498.0 7562.6 7569.7 7578.1 7580.6 7997.4 8060.2 8098.0 8112.6 8121.8 6723.8 7491.7 7509.9 7545.9 7627.6 6836.3 7446.3 7465.3 7509.5 7577.7 7169.2 7186.6 7210.2 7217.9 7222.2 6255.5 6264.7 6309.4 6314.4 6322.2 6473.0 6483.5 6520.6 6532.3 6549.2 10:23:47 INFO - 2016-02-03 10:23:47,650 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,651 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5524.59 Median:6249.22 stddev:1631.20 (26.1%) stddev-sans-first:1589.19 10:23:47 INFO - 2016-02-03 10:23:47,651 DEBUG : BROWSER_OUTPUT: Values: 367.3 370.8 372.1 374.8 385.1 6130.4 6148.8 6155.8 6174.2 6238.3 5820.7 5886.1 5909.9 6105.3 6109.8 4709.1 4742.2 4750.1 4758.3 4759.5 4792.8 4800.0 4808.9 4809.5 4810.6 4515.3 4639.6 4640.8 4729.3 4776.8 4755.5 4756.3 4766.5 4774.7 4778.5 4239.3 4250.6 4251.4 4251.7 4252.5 5701.2 5759.3 5790.8 5794.5 5814.1 5579.4 5589.2 5589.2 5593.5 5600.2 6509.3 6510.2 6518.7 6522.4 6524.7 4718.1 4725.8 4726.1 4727.1 4739.2 6602.3 6760.6 6762.1 6778.6 6780.6 4851.3 4851.7 4851.9 4856.1 4857.8 4913.7 4916.4 4917.6 4919.8 4922.8 5459.4 5565.3 5576.2 5577.1 5578.1 6538.9 6544.4 6546.2 6546.6 6548.7 1715.3 1737.0 1740.6 1740.9 1741.0 1172.3 1202.1 1202.8 1212.5 1230.4 6395.3 6401.0 6405.3 6409.8 6411.3 6761.2 6764.3 6768.8 6769.7 6773.8 6212.7 6260.2 6370.2 6470.4 6476.4 3645.8 3670.4 3677.2 3678.6 3681.1 6947.1 6973.3 6975.6 6986.3 6992.2 6805.6 7023.1 7034.6 7043.0 7045.9 7025.2 7028.2 7030.5 7030.8 7032.6 6551.2 6777.7 6797.8 6847.5 6858.7 6564.9 6675.5 6716.8 6719.5 6741.6 6994.4 6995.6 7000.5 7001.3 7006.1 4636.4 4638.5 4711.9 4713.2 4713.6 6816.5 6820.1 6829.6 6832.8 6840.7 6628.5 6635.9 6636.7 6640.4 6645.0 6518.1 6614.1 6630.1 6631.1 6642.9 6449.1 6476.6 6480.8 6483.6 6490.2 6615.6 6643.6 6659.3 6663.4 6665.0 6397.2 6466.1 6492.1 6502.2 6517.2 10:23:47 INFO - 2016-02-03 10:23:47,651 DEBUG : BROWSER_OUTPUT: 10:23:47 INFO - 2016-02-03 10:23:47,651 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14255.80 Median:53380.83 stddev:17050.15 (31.9%) stddev-sans-first:17067.53 10:23:47 INFO - 2016-02-03 10:23:47,652 DEBUG : BROWSER_OUTPUT: Values: 685.6 725.5 787.2 864.5 869.7 12884.6 13281.2 13323.2 13377.2 13381.1 12565.6 12769.2 12799.9 12815.2 12820.2 616.2 621.4 878.6 901.1 916.8 906.7 910.5 913.0 914.4 914.5 799.3 960.6 968.2 971.0 972.4 805.9 937.4 950.2 952.3 952.4 703.5 704.6 705.4 706.4 706.8 12487.6 12723.9 12755.4 12758.2 12774.1 11969.0 12819.4 13022.1 13052.3 13168.7 9512.2 9835.8 9864.1 9873.3 9919.7 3480.9 3505.4 3523.5 3528.8 3532.6 50182.7 50666.2 50837.5 51222.2 51301.0 9168.5 9302.9 9379.6 9385.2 9419.9 18720.8 18860.3 18872.8 18899.5 18909.5 7253.0 7299.7 7378.5 7390.4 7458.6 4297.4 4397.7 4453.9 4498.1 4516.4 3438.0 3476.4 3478.5 3482.4 3482.8 568.6 592.4 602.9 607.9 609.1 577.7 580.8 586.4 606.6 623.9 8303.6 8388.5 8602.1 8639.1 8731.8 632.9 640.2 642.4 695.4 722.2 3966.7 3979.8 4127.4 4265.8 4345.4 53295.2 53466.5 54672.5 61794.0 62231.0 54025.5 54851.5 55318.4 55521.0 55590.7 49209.8 50283.0 50420.5 50749.0 51175.0 8254.6 8289.2 8580.6 8608.1 8669.8 36881.3 37662.0 38018.2 38814.0 39513.6 48371.3 50085.0 50722.0 51295.7 52507.0 10652.1 11080.5 11146.4 11148.9 11746.4 11297.4 12234.6 12291.8 12443.8 12958.0 10679.8 10747.1 10772.8 11154.2 11438.4 10528.4 10735.8 10817.1 11150.4 11271.9 10257.8 10691.7 10829.5 10845.3 10952.8 9159.0 9254.0 9327.5 9484.4 9728.0 9061.1 9321.3 9396.8 9557.2 9589.2 10:23:47 INFO - 2016-02-03 10:23:47,652 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:23:47 INFO - 2016-02-03 10:23:47,652 DEBUG : BROWSER_OUTPUT: 10:23:48 INFO - 2016-02-03 10:23:48,240 INFO : Browser exited with error code: 0 10:23:48 INFO - 2016-02-03 10:23:48,261 INFO : Completed test dromaeo_css (00:18:30) 10:23:48 INFO - 2016-02-03 10:23:48,261 INFO : Starting test kraken 10:23:48 INFO - 2016-02-03 10:23:48,261 DEBUG : operating with platform_type : linux_ 10:23:48 INFO - 2016-02-03 10:23:48,261 INFO : Initialising browser for kraken test... 10:23:48 INFO - 2016-02-03 10:23:48,267 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvxS3mN/profile http://localhost:39533/getInfo.html 10:23:52 INFO - 2016-02-03 10:23:52,303 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:23:52 INFO - 2016-02-03 10:23:52,303 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:23:52 INFO - 2016-02-03 10:23:52,303 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:23:52 INFO - 2016-02-03 10:23:52,303 DEBUG : BROWSER_OUTPUT: __metrics 10:23:52 INFO - 2016-02-03 10:23:52,552 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:53 INFO - 2016-02-03 10:23:53,735 INFO : Browser initialized. 10:23:53 INFO - 2016-02-03 10:23:53,736 INFO : Running cycle 1/1 for kraken test... 10:23:53 INFO - 2016-02-03 10:23:53,736 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvxS3mN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:24:05 INFO - 2016-02-03 10:24:05,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 134823936 10:24:05 INFO - 2016-02-03 10:24:05,487 DEBUG : BROWSER_OUTPUT: 10:24:07 INFO - 2016-02-03 10:24:07,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39533/tests/kraken/driver.html?testName=audio-beat-detection) 10:24:08 INFO - 2016-02-03 10:24:08,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 165965824 10:24:08 INFO - 2016-02-03 10:24:08,496 DEBUG : BROWSER_OUTPUT: 10:24:11 INFO - 2016-02-03 10:24:11,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39533/tests/kraken/driver.html?testName=audio-dft) 10:24:11 INFO - 2016-02-03 10:24:11,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 164921344 10:24:11 INFO - 2016-02-03 10:24:11,590 DEBUG : BROWSER_OUTPUT: 10:24:14 INFO - 2016-02-03 10:24:14,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39533/tests/kraken/driver.html?testName=audio-fft) 10:24:14 INFO - 2016-02-03 10:24:14,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 161632256 10:24:14 INFO - 2016-02-03 10:24:14,959 DEBUG : BROWSER_OUTPUT: 10:24:16 INFO - 2016-02-03 10:24:16,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39533/tests/kraken/driver.html?testName=audio-oscillator) 10:24:17 INFO - 2016-02-03 10:24:17,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 160669696 10:24:17 INFO - 2016-02-03 10:24:17,474 DEBUG : BROWSER_OUTPUT: 10:24:19 INFO - 2016-02-03 10:24:19,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:24:20 INFO - 2016-02-03 10:24:20,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 161062912 10:24:20 INFO - 2016-02-03 10:24:20,190 DEBUG : BROWSER_OUTPUT: 10:24:23 INFO - 2016-02-03 10:24:23,008 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39533/tests/kraken/driver.html?testName=imaging-darkroom) 10:24:23 INFO - 2016-02-03 10:24:23,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 160657408 10:24:23 INFO - 2016-02-03 10:24:23,571 DEBUG : BROWSER_OUTPUT: 10:24:26 INFO - 2016-02-03 10:24:26,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39533/tests/kraken/driver.html?testName=imaging-desaturate) 10:24:27 INFO - 2016-02-03 10:24:27,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 160464896 10:24:27 INFO - 2016-02-03 10:24:27,471 DEBUG : BROWSER_OUTPUT: 10:24:30 INFO - 2016-02-03 10:24:30,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39533/tests/kraken/driver.html?testName=json-parse-financial) 10:24:30 INFO - 2016-02-03 10:24:30,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 161316864 10:24:30 INFO - 2016-02-03 10:24:30,697 DEBUG : BROWSER_OUTPUT: 10:24:32 INFO - 2016-02-03 10:24:32,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:24:32 INFO - 2016-02-03 10:24:32,812 DEBUG : BROWSER_OUTPUT: RSS: Main: 168144896 10:24:32 INFO - 2016-02-03 10:24:32,813 DEBUG : BROWSER_OUTPUT: 10:24:34 INFO - 2016-02-03 10:24:34,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:24:35 INFO - 2016-02-03 10:24:35,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 165715968 10:24:35 INFO - 2016-02-03 10:24:35,135 DEBUG : BROWSER_OUTPUT: 10:24:37 INFO - 2016-02-03 10:24:37,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:24:37 INFO - 2016-02-03 10:24:37,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 172457984 10:24:37 INFO - 2016-02-03 10:24:37,669 DEBUG : BROWSER_OUTPUT: 10:24:40 INFO - 2016-02-03 10:24:40,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:24:40 INFO - 2016-02-03 10:24:40,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 177410048 10:24:40 INFO - 2016-02-03 10:24:40,630 DEBUG : BROWSER_OUTPUT: 10:24:43 INFO - 2016-02-03 10:24:43,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:43 INFO - 2016-02-03 10:24:43,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 175591424 10:24:43 INFO - 2016-02-03 10:24:43,665 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39533/tests/kraken/driver.html?testName=ai-astar) 10:24:45 INFO - 2016-02-03 10:24:45,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 234950656 10:24:45 INFO - 2016-02-03 10:24:45,546 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,547 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:24:45 INFO - 2016-02-03 10:24:45,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:24:45 INFO - 2016-02-03 10:24:45,548 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:24:45 INFO - 2016-02-03 10:24:45,548 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:24:45 INFO - 2016-02-03 10:24:45,548 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;105;107;108;109;97;109;108;110 10:24:45 INFO - 2016-02-03 10:24:45,549 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;121;148;158;121;149;147;120;158;120 10:24:45 INFO - 2016-02-03 10:24:45,549 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;160;159;160;159;164;159;160 10:24:45 INFO - 2016-02-03 10:24:45,549 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;73;143;73;72;72;70;159;71 10:24:45 INFO - 2016-02-03 10:24:45,550 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;133;92;92;91;155;91;92;141 10:24:45 INFO - 2016-02-03 10:24:45,550 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;109;109 10:24:45 INFO - 2016-02-03 10:24:45,550 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;147;146;145;146;146;145;145;145 10:24:45 INFO - 2016-02-03 10:24:45,550 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 10:24:45 INFO - 2016-02-03 10:24:45,551 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;58;58;58;57;57;57;58;55;55 10:24:45 INFO - 2016-02-03 10:24:45,551 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;65;65;66;64;65;64;64 10:24:45 INFO - 2016-02-03 10:24:45,551 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;78;78;79;79;79;79;79;80;81 10:24:45 INFO - 2016-02-03 10:24:45,552 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;110;121;118;123;120;124;110;114;111 10:24:45 INFO - 2016-02-03 10:24:45,552 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;133;152;136;135;144;132;145;140;144;141 10:24:45 INFO - 2016-02-03 10:24:45,552 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;65;64;64;64;63;65;63;66 10:24:45 INFO - 2016-02-03 10:24:45,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:24:45 INFO - 2016-02-03 10:24:45,553 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:24:45 INFO - 2016-02-03 10:24:45,553 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,883 10:24:45 INFO - 2016-02-03 10:24:45,553 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:24:45 INFO - 2016-02-03 10:24:45,553 DEBUG : BROWSER_OUTPUT: __startTimestamp1454523885547__endTimestamp 10:24:45 INFO - 2016-02-03 10:24:45,554 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,555 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:24:45 INFO - 2016-02-03 10:24:45,555 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:24:45 INFO - 2016-02-03 10:24:45,555 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.77 (3.5%) stddev-sans-first:3.98 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 105.0 107.0 108.0 109.0 97.0 109.0 108.0 110.0 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.00 Median:148.00 stddev:16.39 (11.1%) stddev-sans-first:17.06 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: Values: 148.0 121.0 148.0 158.0 121.0 149.0 147.0 120.0 158.0 120.0 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,556 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 160.0 159.0 160.0 159.0 164.0 159.0 160.0 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.50 Median:71.50 stddev:33.69 (47.1%) stddev-sans-first:35.20 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 73.0 143.0 73.0 72.0 72.0 70.0 159.0 71.0 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:92.00 stddev:25.33 (27.5%) stddev-sans-first:26.27 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 133.0 92.0 92.0 91.0 155.0 91.0 92.0 141.0 10:24:45 INFO - 2016-02-03 10:24:45,557 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,558 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.20 (2.1%) stddev-sans-first:1.22 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: Values: 56.0 58.0 58.0 58.0 57.0 57.0 57.0 58.0 55.0 55.0 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 10:24:45 INFO - 2016-02-03 10:24:45,559 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 65.0 66.0 64.0 65.0 64.0 64.0 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:0.94 (1.2%) stddev-sans-first:0.93 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: Values: 78.0 78.0 78.0 79.0 79.0 79.0 79.0 79.0 80.0 81.0 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:119.00 stddev:5.31 (4.5%) stddev-sans-first:5.63 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: Values: 117.0 110.0 121.0 118.0 123.0 120.0 124.0 110.0 114.0 111.0 10:24:45 INFO - 2016-02-03 10:24:45,560 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:142.50 stddev:6.29 (4.4%) stddev-sans-first:6.10 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: Values: 133.0 152.0 136.0 135.0 144.0 132.0 145.0 140.0 144.0 141.0 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 65.0 64.0 64.0 64.0 63.0 65.0 63.0 66.0 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:24:45 INFO - 2016-02-03 10:24:45,562 DEBUG : BROWSER_OUTPUT: 10:24:46 INFO - 2016-02-03 10:24:46,260 INFO : Browser exited with error code: 0 10:24:46 INFO - 2016-02-03 10:24:46,313 INFO : Completed test kraken (00:00:58) 10:24:46 INFO - 2016-02-03 10:24:46,313 INFO : Starting test v8_7 10:24:46 INFO - 2016-02-03 10:24:46,313 DEBUG : operating with platform_type : linux_ 10:24:46 INFO - 2016-02-03 10:24:46,313 INFO : Initialising browser for v8_7 test... 10:24:46 INFO - 2016-02-03 10:24:46,319 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuPsSVT/profile http://localhost:39533/getInfo.html 10:24:50 INFO - 2016-02-03 10:24:50,666 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:24:50 INFO - 2016-02-03 10:24:50,666 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:24:50 INFO - 2016-02-03 10:24:50,666 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:24:50 INFO - 2016-02-03 10:24:50,666 DEBUG : BROWSER_OUTPUT: __metrics 10:24:50 INFO - 2016-02-03 10:24:50,868 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:51 INFO - 2016-02-03 10:24:51,638 INFO : Browser initialized. 10:24:51 INFO - 2016-02-03 10:24:51,639 INFO : Running cycle 1/1 for v8_7 test... 10:24:51 INFO - 2016-02-03 10:24:51,639 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpuPsSVT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:25:03 INFO - 2016-02-03 10:25:03,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 134479872 10:25:03 INFO - 2016-02-03 10:25:03,371 DEBUG : BROWSER_OUTPUT: 10:25:24 INFO - 2016-02-03 10:25:24,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:39533/tests/v8_7/run.html (next: http://localhost:39533/tests/v8_7/run.html) 10:25:25 INFO - 2016-02-03 10:25:25,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 424128512 10:25:25 INFO - 2016-02-03 10:25:25,018 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,019 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:25:25 INFO - 2016-02-03 10:25:25,019 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |0;Richards;167.47613465081227 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.63615409944023 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |4;RayTrace;962.4639076034649 10:25:25 INFO - 2016-02-03 10:25:25,020 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508 10:25:25 INFO - 2016-02-03 10:25:25,021 DEBUG : BROWSER_OUTPUT: |6;Boyer;10578.947368421053 10:25:25 INFO - 2016-02-03 10:25:25,021 DEBUG : BROWSER_OUTPUT: |7;RegExp;24214.285714285714 10:25:25 INFO - 2016-02-03 10:25:25,021 DEBUG : BROWSER_OUTPUT: |8;Splay;527.7044854881267 10:25:25 INFO - 2016-02-03 10:25:25,021 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 10:25:25 INFO - 2016-02-03 10:25:25,021 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: __startTimestamp1454523925018__endTimestamp 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,022 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: Values: 167.5 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.64 Median:164.64 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: Values: 164.6 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: Values: 278.6 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,023 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: Values: 5186.5 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: Values: 962.5 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,024 DEBUG : BROWSER_OUTPUT: Values: 542.6 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10578.95 Median:10578.95 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: Values: 10578.9 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24214.29 Median:24214.29 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: Values: 24214.3 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,025 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:527.70 Median:527.70 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: Values: 527.7 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: Values: 4822.1 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:25:25 INFO - 2016-02-03 10:25:25,026 DEBUG : BROWSER_OUTPUT: 10:25:25 INFO - 2016-02-03 10:25:25,700 INFO : Browser exited with error code: 0 10:25:25 INFO - 2016-02-03 10:25:25,711 INFO : Completed test v8_7 (00:00:39) 10:25:25 INFO - 2016-02-03 10:25:25,997 INFO : Completed test suite (00:20:08) 10:25:25 INFO - 2016-02-03 10:25:25,997 DEBUG : Working with test: dromaeo_css 10:25:25 INFO - 2016-02-03 10:25:25,997 DEBUG : Generating results file: dromaeo_css 10:25:25 INFO - 2016-02-03 10:25:25,998 DEBUG : Working with test: kraken 10:25:25 INFO - 2016-02-03 10:25:25,998 DEBUG : Generating results file: kraken 10:25:25 INFO - 2016-02-03 10:25:25,998 INFO : javascript benchmark 10:25:25 INFO - 2016-02-03 10:25:25,998 DEBUG : Working with test: v8_7 10:25:25 INFO - 2016-02-03 10:25:25,999 DEBUG : Generating results file: v8_7 10:25:26 INFO - 2016-02-03 10:25:25,999 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:26 INFO - 2016-02-03 10:25:26,051 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 10:25:26 INFO - 2016-02-03 10:25:26,051 DEBUG : process_Request line: dromaeo_css 7360.35 graph.html#tests=[[72,53,35]] 10:25:26 INFO - 2016-02-03 10:25:26,051 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:26 INFO - 2016-02-03 10:25:26,081 DEBUG : process_Request line: kraken 1472.30 graph.html#tests=[[232,53,35]] 10:25:26 INFO - 2016-02-03 10:25:26,081 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:25:26 INFO - 2016-02-03 10:25:26,196 DEBUG : process_Request line: v8_7 23235.95 graph.html#tests=[[230,53,35]] 10:25:26 INFO - 2016-02-03 10:25:26,197 INFO : javascript benchmark 10:25:26 INFO - 2016-02-03 10:25:26,200 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3387.474941384085, 3452.326796274724, 3482.286131343075, 3486.1981744198833, 3493.336266109439, 5742.0, 5747.770089196427, 5762.423757624246, 5773.3937936516695, 5774.451427114428, 5753.769849206027, 5764.740586673599, 5796.536277097833, 5797.5651826113, 5818.389069147742, 5052.368453943257, 5230.92153617697, 5260.947390526103, 5328.600354973373, 5353.652012619187, 5241.161414173733, 5242.344706911636, 5248.448912864133, 5250.186221135711, 5255.264263003163, 5108.565771909373, 5188.533032027117, 5215.113430716788, 5216.478352164791, 5244.816431424901, 5191.558717509016, 5289.47105289468, 5292.44429334922, 5293.338332708411, 5296.205569164617, 5195.246689230041, 5215.139501982168, 5225.634205605571, 5279.260903473517, 5294.629375943686, 5376.247325374451, 5394.757235924393, 5478.068728316196, 5488.807891723811, 5582.106862901916, 6130.601510901777, 6154.415330543591, 6165.32181460039, 6168.167297414881, 6172.074188871705, 6114.357992410822, 6178.289496707891, 6193.1329613854095, 6194.473469755031, 6195.287541932646, 5488.615796894219, 5598.972005139989, 5698.373178950354, 5797.88404231913, 5825.097109947922, 6266.373362663697, 6267.2165979252595, 6343.048542718537, 6343.460805831463, 6357.936420635827, 5941.316748573883, 6099.817005489843, 6102.603330783485, 6108.053251745987, 6108.144859719643, 5961.165436838846, 6044.395560444008, 6046.727897244635, 6082.665453400105, 6113.29697084841, 6029.6683682397015, 6129.693515324305, 6130.662813545208, 6131.049687298476, 6132.41742034506, 5875.353711091777, 6054.152418661391, 6130.754769809158, 6151.323354431099, 6152.600080994811, 4585.679002469795, 4627.097715945359, 4654.813807447732, 4656.697314674535, 4679.9532004680195, 4135.9172816544105, 4167.6457501112745, 4179.6029377209115, 4196.727212731163, 4209.368594710818, 5619.690916999522, 5717.628354156966, 5717.914231286534, 5798.188253644493, 5806.506446952057, 6082.200779309964, 6238.189035425366, 6246.063090536365, 6263.906041409383, 6267.71795269214, 5896.027155519377, 5901.203337549462, 5924.555658325643, 5928.67392293428, 5946.583739138218, 5193.221016847503, 5271.815486457956, 5319.308489896289, 5351.652142610717, 5360.222767698662, 6203.410675985774, 6225.0, 6240.469560087444, 6242.906356404657, 6248.375162483806, 6014.248218972629, 6036.486898613667, 6039.094135879654, 6039.365866584121, 6048.36492168316, 6098.853789760313, 6104.725287361991, 6214.658193799384, 6222.751089956351, 6393.8721225576155, 6089.847753806191, 6102.816915492543, 6104.38956104386, 6135.631862088289, 6140.57016008893, 6217.409346112112, 6232.376762323732, 6234.844128896814, 6239.282482514569, 6242.968785156045, 5745.454181852718, 5849.94150058494, 5949.940500594938, 6034.698265086816, 6062.302835174011, 5804.0, 5949.881002380015, 5958.344582096052, 5958.910616340671, 5963.0, 5671.064274394678, 5850.970745146247, 5885.882282354414, 5892.322382926019, 5893.6463812171405, 5847.0, 5901.291844978458, 5947.375525569752, 5976.372480889618, 5982.7008649568215, 5927.496162826035, 5940.702964851654, 5950.107483877453, 5952.375000624872, 5975.37258587842], "unit": "ms", "name": "dojo.html", "value": 5647.3614426176455}, {"lowerIsBetter": false, "replicates": [610.2524407600687, 611.9204503414555, 618.6350053468456, 639.5075791640436, 639.5938579002334, 36343.454848177265, 37128.81435592822, 37170.81414592927, 37242.0, 37331.0, 45192.322115168216, 45799.54200457995, 45821.54178458214, 45828.770856145755, 45887.0, 7889.250521200505, 8006.959965200195, 8012.5593092379895, 8917.108289171063, 9069.637214511444, 10635.415052172128, 10862.674119776419, 10878.673639790819, 10881.183911206692, 10884.61903833366, 10486.895131048668, 10552.208584356165, 10587.576496940152, 10589.576416943313, 10596.152307815395, 10587.258891877533, 10672.30630009047, 10690.679279621623, 10697.839532406942, 10700.839487407695, 10429.843552346721, 10550.050495455445, 10561.683149505527, 10564.049235568758, 10565.0, 44205.336919946225, 44652.0, 44672.776636116934, 44730.0, 44763.328550071776, 3200.647928727838, 3257.218267615779, 3276.2464633134514, 3366.0, 4051.169510250421, 32152.839235803673, 32163.83918080418, 32192.83903580467, 32422.351552969045, 32590.511142332885, 3289.687479689426, 3362.0922350965348, 3362.714169295613, 3400.3709313776785, 3466.185446420089, 298252.0, 302219.0, 302827.0, 303549.0, 304099.0, 56187.71906140443, 65660.0, 66443.66778166078, 66933.665331674, 66990.66504667446, 50917.74541127345, 73102.0, 74520.62739686266, 74587.62706186435, 74644.25355746373, 18284.451466456027, 18389.172487238106, 18490.260389584266, 18492.630147396976, 18513.0, 14006.0, 14058.0, 14085.71828563423, 14088.577342679737, 14096.788548171786, 20773.688394674093, 20945.057472413777, 20959.68560471594, 20963.895180524305, 21010.2646407375, 7463.925360746323, 7482.812929676693, 7551.809975107267, 7552.924470755332, 7636.885446718304, 964.1419136968104, 976.6923419122953, 987.8419452887504, 991.1971303244395, 1055.5724931402794, 29728.256793580334, 29836.254093647833, 30415.087547373616, 30795.538066929013, 30941.071767847, 995.9751006224902, 1038.896110388955, 1057.4765491081964, 1107.429673718036, 1178.8054970929873, 13111.672208194681, 13545.525906593222, 14014.789778153336, 16149.434769783002, 16212.0, 344511.0, 346205.0, 347187.0, 347247.0, 348493.0, 55141.72429137828, 55377.16934245989, 55461.1680824788, 55643.44356556464, 55666.72166639141, 1459.1026518690928, 1466.7579849324743, 1471.4923351443736, 1473.3075454536352, 1485.4206859324872, 26305.605415918395, 29319.267018324714, 29824.25439364033, 30193.09420717382, 30871.84564077165, 51237.74381128071, 51575.48424515857, 51584.0, 51593.484065160366, 51629.48370516397, 264315.0, 264477.0, 265025.0, 265448.0, 265930.0, 30425.543616846207, 30649.0, 33765.32469350648, 33769.49345759865, 34245.31509369848, 40110.59889401068, 40170.0, 40554.79722601368, 41000.384994224514, 41675.0, 35919.28161436809, 36384.27231455409, 36774.44838327374, 37103.62896371002, 37266.25467490689, 37301.81349093237, 37695.81152094222, 38498.0, 42605.0, 42654.573454266305, 36100.27799444049, 36562.0, 36936.630633694396, 37378.8131059343, 37596.436053459765, 32630.51054234236, 32662.673373265963, 32822.835885820416, 32982.175445614055, 33017.834910826256, 25866.61200082038, 26486.424447471367, 26654.733452665227, 26667.599985999837, 28173.490652313663], "unit": "ms", "name": "ext.html", "value": 19637.892633752585}, {"lowerIsBetter": false, "replicates": [384.4156881540059, 386.73508646577113, 388.74731424574026, 389.4489297643834, 392.3154096102301, 17049.914750426247, 18198.363057292998, 18382.90808545957, 18507.074646267683, 19376.22495100198, 18087.18607662655, 18229.908850455762, 18235.0, 18611.255549778027, 18629.0, 5558.610897237195, 5719.28508936383, 5721.570882183832, 5725.198472213893, 5732.398098199692, 5582.748776305076, 5639.887202255953, 5664.235328230698, 5671.376148623648, 5676.063449530822, 4326.84856030039, 4430.712003719764, 5622.184783206432, 5626.240457538242, 5626.831195064135, 6045.546584006195, 6196.628202307876, 6231.034189700604, 6233.438990490855, 6237.064440333941, 5423.050966080959, 5463.371712253102, 5465.371482279509, 5471.316085489314, 5535.059039963216, 21979.0, 22023.22918697854, 22166.66749998735, 22594.435139121488, 22657.0, 2216.767239439868, 2253.0537174386795, 2255.571441426124, 2275.4538910661486, 2276.965845512302, 13532.188068715908, 13736.65658358539, 13797.172169669751, 13982.790258146137, 14119.082259653089, 1691.4418241980118, 1727.1709579401831, 1736.4530172995592, 1752.8860624059396, 1766.3287950578826, 66336.0, 67062.9940550892, 67565.0, 68425.0, 68799.65600171968, 9991.900080999098, 10064.043915827984, 10101.0, 10238.027387398186, 10483.423411712276, 13199.736005279841, 13217.471301148038, 13230.0, 13234.272115033573, 13349.199048057148, 8028.277455029075, 8118.634661440249, 8123.634436450374, 8441.198086181803, 8599.957000215085, 8122.147174546588, 8151.062627797761, 8186.099529051799, 8206.261436470626, 8238.752837414888, 6138.662373569497, 6290.654014029273, 6402.167718196604, 6475.093486911836, 6521.543491955517, 1765.7527946087557, 1776.9289228430976, 1833.6516061948187, 1869.0, 1910.980890191108, 984.3503287829998, 1020.3724709303873, 1060.7136073260176, 1076.7361996310954, 1131.332513816852, 16275.023498590122, 16998.450232465228, 17266.309347625953, 17321.220545075503, 17840.46478605644, 834.5576844272424, 938.3384713776771, 943.6697155995485, 958.6213445688913, 1085.7177133945074, 9454.48000359973, 9743.61025558984, 9802.411855288563, 9867.062629050371, 10197.541110650038, 441886.0, 524358.0, 618075.0, 620686.0, 624490.0, 83061.0, 85138.0, 86111.56944215365, 86393.56803216069, 86759.0, 1217.117589747426, 1220.8290839282508, 1223.406647775828, 1232.6671798614325, 1242.0932719115096, 14937.551873443814, 15144.242787860783, 15203.923980380026, 15286.312115955032, 15509.069455832687, 37744.62255377411, 38242.61757382502, 38968.80515597404, 39153.804230979804, 39657.0, 54414.18378724243, 55628.72185639046, 58757.41242587519, 59064.70467647634, 61273.0, 14941.62645933817, 15286.464973725866, 15300.158491283086, 15310.846891531388, 15750.76373854416, 12342.259464432163, 12525.498980040697, 12729.172603780724, 18883.716744249123, 19665.508362291057, 10525.315854469434, 10565.471726413494, 10626.89373106259, 10684.358938463716, 10735.0, 10895.346279223271, 11101.611443599435, 11220.270682405617, 11388.430578471209, 11604.88395116038, 9142.0, 9358.859617105885, 11041.0, 11306.0, 11788.23376480526, 15007.32467038964, 15217.619559510658, 15218.0, 15376.615584610474, 15461.149636770086, 15650.9217453912, 15795.921020394824, 15931.044137351795, 16196.595085122966, 16259.430919917746], "unit": "ms", "name": "jquery.html", "value": 9495.430272123418}, {"lowerIsBetter": false, "replicates": [1467.750482417989, 1528.3275358842104, 1656.6106964863263, 1713.5630414244365, 1856.7307740377655, 7163.35529802319, 7282.781516554499, 7592.620368981549, 7950.36397088233, 7963.442559020864, 7746.651400686968, 7878.094019187795, 8015.599220038989, 8017.799555011113, 8027.839443211133, 2386.5107652931106, 2426.9029238830426, 2430.562498750224, 2431.8905649245826, 2435.062500937143, 2180.1824315881545, 2198.934031979043, 2208.094681180716, 2326.6161083421216, 2390.22317746733, 2357.1867705641525, 2360.5042940982416, 2363.5627408929317, 2365.4677697518005, 2367.8342516023886, 2294.804941579968, 2326.127702111708, 2326.6626339180725, 2328.8951997160084, 2341.9297421077395, 2393.6888204533475, 2395.4849707312837, 2431.343537244934, 2438.146648672968, 2443.596806526921, 8091.514509129471, 8171.18288171184, 8187.058488273865, 8194.467359621665, 8205.179482051806, 5019.29729837823, 5082.136036873703, 5103.260027296058, 5151.922721159186, 5152.742362881841, 3200.247941733691, 3218.372417378612, 3241.983790081058, 3249.171461277359, 3283.343331333719, 1041.0838462153333, 1051.758095638, 1065.9467026648636, 1071.0681706915034, 1083.2363183955292, 11383.203175777699, 11390.544378224944, 11397.772044559146, 11411.144164187719, 11440.027597654127, 4616.192166370872, 4641.721496710141, 4665.4168228971375, 4678.204705200124, 4708.340832283483, 9805.01949805028, 9811.116999470081, 9811.26415518839, 9815.214782817358, 9816.312858099864, 5169.431362550116, 5176.094183517869, 5177.249298851721, 5178.197379406198, 5202.375714914235, 4722.173619616553, 4723.385959825269, 4726.338312636233, 4726.71639701619, 4731.455882573479, 4060.675145988314, 4148.066684995852, 4151.97924010384, 4176.60322269384, 4186.330187170038, 1202.0984261803646, 1213.1447329632588, 1217.7442737025324, 1275.5663074554695, 1334.8932085433141, 1026.2662196529518, 1049.2340591368343, 1049.7218237167158, 1188.3464094747853, 1327.0445279398818, 7185.425165986709, 7240.4569657275915, 7275.490715649959, 7306.780796576111, 7314.634268286564, 1141.0716581135878, 1147.3173461790223, 1147.7302833834042, 1148.0413854431476, 1150.9021733152777, 5371.731413429313, 5476.17857321397, 5488.7530061147345, 5489.451054894558, 5493.505584497414, 9868.0, 10031.047050530187, 10140.935201803852, 10323.07092361676, 10351.585936562604, 10020.599176032876, 10159.390436573682, 10206.387616743019, 10209.897901021044, 10212.183025357954, 7607.505512141804, 7807.0, 7841.451098423056, 7857.057153141545, 7858.0570331560575, 7116.039334689751, 7172.031775710212, 7212.098487689039, 7238.963805181151, 7248.565086094851, 8792.42849214799, 8809.207171354608, 8827.0, 9045.77385565366, 9063.728088157366, 8984.101589840964, 9031.277497800029, 9128.634854605742, 9161.86257206129, 9168.862467063132, 7498.0, 7562.621868906643, 7569.735059272899, 7578.12851522082, 7580.583067931317, 7997.360211183208, 8060.15368386311, 8098.0, 8112.634931428218, 8121.8375632488205, 6723.831904202434, 7491.662875170521, 7509.88735168962, 7545.886811697938, 7627.618619069135, 6836.28219036994, 7446.25537446251, 7465.29079737424, 7509.549427034177, 7577.734779282699, 7169.211386747349, 7186.640667966685, 7210.206877243604, 7217.927820721936, 7222.169450513258, 6255.493045865901, 6264.655443950626, 6309.400606942333, 6314.368563143649, 6322.241331040304, 6473.029045643191, 6483.481321494363, 6520.608763474207, 6532.314107018695, 6549.214094308713], "unit": "ms", "name": "mootools.html", "value": 4703.83741682173}, {"lowerIsBetter": false, "replicates": [367.31129132875856, 370.7645645015416, 372.073536893136, 374.78262607687543, 385.12192201779936, 6130.417610327017, 6148.754049838007, 6155.784547540837, 6174.228221472316, 6238.251409830816, 5820.738066786994, 5886.146508756238, 5909.85225369366, 6105.328413874481, 6109.847253818646, 4709.105269998707, 4742.217534106868, 4750.073735621547, 4758.286257061452, 4759.500252473493, 4792.83225087122, 4800.015996720664, 4808.927866081994, 4809.5430934061205, 4810.639202059842, 4515.322701594754, 4639.605633521155, 4640.79116439761, 4729.290606409032, 4776.832810851621, 4755.476897541268, 4756.310335001405, 4766.523347665206, 4774.73738944358, 4778.498257682928, 4239.300515414953, 4250.574942505756, 4251.44731184944, 4251.723637963522, 4252.510961239466, 5701.2018317435595, 5759.308882934033, 5790.826275211751, 5794.5074668653215, 5814.069748840166, 5579.38626751057, 5589.217509548666, 5589.245451863987, 5593.468620481048, 5600.243967064435, 6509.3490650935, 6510.18622672166, 6518.739250429977, 6522.412982831568, 6524.706388212494, 4718.05638872227, 4725.76371181443, 4726.149293127236, 4727.149113159629, 4739.241721324606, 6602.3067577904585, 6760.628165450898, 6762.087118239024, 6778.627175505345, 6780.627065511395, 4851.2723091535845, 4851.708897466164, 4851.902961940812, 4856.125897338442, 4857.805687772449, 4913.70517768935, 4916.434610019822, 4917.606591472673, 4919.7540122993705, 4922.827701030446, 5459.372172200247, 5565.30433695788, 5576.219329293902, 5577.135543990688, 5578.107502799533, 6538.934610653928, 6544.411003009752, 6546.214454265423, 6546.574472659262, 6548.6725663716625, 1715.2795825753215, 1736.9925443243142, 1740.5822602575545, 1740.85202757767, 1741.0250259854522, 1172.284906207213, 1202.1164444133556, 1202.7955247607927, 1212.5271144253747, 1230.366361323919, 6395.296517383084, 6400.97584386496, 6405.263394709668, 6409.807705768834, 6411.294757576663, 6761.154855643044, 6764.323567643295, 6768.830779230559, 6769.72921083161, 6773.830654233683, 6212.72042758077, 6260.186175797208, 6370.203724534434, 6470.352964703492, 6476.384743449365, 3645.76302540334, 3670.4127339625534, 3677.154254521475, 3678.576963649161, 3681.116532032293, 6947.096877405905, 6973.302669733088, 6975.581465112109, 6986.301369862973, 6992.16094068715, 6805.557638753465, 7023.086998690138, 7034.6482675866, 7043.049188359609, 7045.92954070463, 7025.192102908231, 7028.156621205488, 7030.472714546429, 7030.789076327718, 7032.648367581601, 6551.181102362205, 6777.728890844311, 6797.762078327235, 6847.452203823782, 6858.691358888762, 6564.934350656432, 6675.532712710258, 6716.764913228014, 6719.496037797087, 6741.59550426976, 6994.370506654425, 6995.580265184105, 7000.50996430245, 7001.334873187039, 7006.124234470692, 4636.397268355092, 4638.536146385334, 4711.9293210602555, 4713.151632706009, 4713.62291016711, 6816.488763342868, 6820.147481564804, 6829.590224586541, 6832.760853370307, 6840.692168852314, 6628.469722422291, 6635.9004614929845, 6636.668166591748, 6640.435562977201, 6644.970029645413, 6518.120053792677, 6614.10709554204, 6630.138082049302, 6631.0716499689115, 6642.867142657216, 6449.097126402214, 6476.6114033158165, 6480.837979050561, 6483.578567393104, 6490.188726409199, 6615.569987950767, 6643.634600097041, 6659.334066593302, 6663.433608143362, 6665.0, 6397.200349956255, 6466.094746735367, 6492.091107245084, 6502.187226596676, 6517.185351831021], "unit": "ms", "name": "prototype.html", "value": 5008.3954977204885}, {"lowerIsBetter": false, "replicates": [685.6023506366308, 725.5066554742776, 787.2442455242966, 864.5417928497899, 869.7390782765173, 12884.613461596144, 13281.203127812338, 13323.200607963518, 13377.197368157917, 13381.130226535268, 12565.623031309075, 12769.23384596925, 12799.872001279984, 12815.167014144097, 12820.230786152837, 616.2143267334162, 621.4313902778974, 878.5958459108801, 901.085398320705, 916.7662246127228, 906.650939388337, 910.5401772105077, 912.9726108216731, 914.4239129348534, 914.5335878701877, 799.3046049936535, 960.6493629825134, 968.2254196642693, 970.9660161894335, 972.4408465132542, 805.9194080591923, 937.3625934364629, 950.1686024728363, 952.295301476909, 952.3666761603525, 703.4583370804503, 704.6441547018774, 705.4497491956282, 706.3995603736834, 706.8197609609516, 12487.625371238877, 12723.872761272454, 12755.362231888368, 12758.170718903242, 12774.105812593029, 11969.0, 12819.446095328687, 13022.088453808143, 13052.34738263083, 13168.670783230496, 9512.191463725592, 9835.803283934281, 9864.062914023156, 9873.308868379216, 9919.702408927744, 3480.89557313281, 3505.4216054351, 3523.541939547868, 3528.7706299090733, 3532.5760908691122, 50182.749086254335, 50666.24000639993, 50837.49162508402, 51222.23166652503, 51300.97398052055, 9168.495732734631, 9302.86045709315, 9379.624815007322, 9385.155336019654, 9419.90580094204, 18720.812791871907, 18860.339888103852, 18872.81127188738, 18899.527511812314, 18909.52726181829, 7253.0, 7299.671514781848, 7378.520396174232, 7390.408767298603, 7458.627068646546, 4297.39836422901, 4397.714148580332, 4453.933191002137, 4498.145352383037, 4516.412866327357, 3437.98579419072, 3476.443768996999, 3478.4956181353564, 3482.355764183634, 3482.7562070655317, 568.6218664588085, 592.4342253148233, 602.8583282928508, 607.9118527813442, 609.1046162141645, 577.6851615869361, 580.8334910782804, 586.4077281945181, 606.6390497653889, 623.9032949892774, 8303.584820759059, 8388.538630375266, 8602.096779838152, 8639.13608639131, 8731.825363492695, 632.8797528469668, 640.1805688718448, 642.408983734965, 695.3741632530662, 722.2380388689983, 3966.742161759534, 3979.801009949491, 4127.360259159835, 4265.765382903908, 4345.3699213613845, 53295.20057199145, 53466.465335346926, 54672.45327546753, 61794.0, 62231.0, 54025.459745402826, 54851.451485485435, 55318.44681553214, 55521.0, 55590.72204639032, 49209.753951230734, 50283.0, 50420.49579504231, 50749.0, 51175.0, 8254.628541715758, 8289.212524810133, 8580.613872375883, 8608.053114157563, 8669.783255418664, 36881.262374751816, 37662.0, 38018.2396352077, 38814.0, 39513.60486395214, 48371.27443088286, 50085.0, 50722.0, 51295.74352128216, 52507.0, 10652.147828173882, 11080.501377438195, 11146.386948717898, 11148.944255278671, 11746.35395053246, 11297.43512824339, 12234.571789987307, 12291.75416491683, 12443.813342799684, 12958.013837200364, 10679.839802403125, 10747.086497647475, 10772.838407423738, 11154.219204655596, 11438.37088960082, 10528.420936848546, 10735.838962415413, 10817.1346292298, 11150.442477875911, 11271.943640281746, 10257.794844103226, 10691.679249622524, 10829.458527073457, 10845.349279043283, 10952.780944381228, 9158.95420522893, 9253.953730231306, 9327.533623318943, 9484.383515071499, 9727.951360243154, 9061.093890610886, 9321.254299656146, 9396.77085882364, 9557.235421166151, 9589.232861371212], "unit": "ms", "name": "yui.html", "value": 6408.358573898957}], "name": "dromaeo_css", "value": 7360.348778498345}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 107.0, 108.0, 109.0, 97.0, 109.0, 108.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [148.0, 121.0, 148.0, 158.0, 121.0, 149.0, 147.0, 120.0, 158.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 160.0, 159.0, 164.0, 159.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 143.0, 73.0, 72.0, 72.0, 70.0, 159.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 133.0, 92.0, 92.0, 91.0, 155.0, 91.0, 92.0, 141.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 58.0, 57.0, 57.0, 57.0, 58.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 56.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 78.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 79.0}, {"lowerIsBetter": true, "replicates": [117.0, 110.0, 121.0, 118.0, 123.0, 120.0, 124.0, 110.0, 114.0, 111.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.8}, {"lowerIsBetter": true, "replicates": [133.0, 152.0, 136.0, 135.0, 144.0, 132.0, 145.0, 140.0, 144.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0, 63.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1472.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [164.63615409944023], "unit": "score", "name": "DeltaBlue", "value": 401.60073199999994}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [10578.947368421053], "unit": "score", "name": "Boyer", "value": 62.99899004975127}, {"lowerIsBetter": false, "replicates": [24214.285714285714], "unit": "score", "name": "RegExp", "value": 37.621799410029524}, {"lowerIsBetter": false, "replicates": [527.7044854881267], "unit": "score", "name": "Splay", "value": 154.42544500000002}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23235.95330103037}]} 10:25:26 INFO - RETURN: dromaeo_css: 7360.35 10:25:26 INFO - RETURN: kraken: 1472.30 10:25:26 INFO - RETURN: v8_7: 23235.95 10:25:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23235.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1472.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7360.35"}}} 10:25:26 INFO - Return code: 0 10:25:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:25:26 INFO - # TBPL SUCCESS # 10:25:26 INFO - Running post-action listener: _resource_record_post_action 10:25:26 INFO - Running post-run listener: _resource_record_post_run 10:25:27 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 498012160; Read time: 0; Write time: 327632 10:25:27 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 235356160; Read time: 0; Write time: 206656 10:25:27 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 262656000; Read time: 0; Write time: 120976 10:25:27 INFO - Running post-run listener: _upload_blobber_files 10:25:27 INFO - Blob upload gear active. 10:25:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:25:27 INFO - Copying logs to upload dir... 10:25:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.057737 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-03 10:25:27.315012) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-03 10:25:27.318986) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010073 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-linux64/1454513789/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-03 10:25:27.370695) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:25:27.371037) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1454521249.30521-594441555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004639 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-03 10:25:27.421891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 10:25:27.422530) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-03 10:25:27.422953) ========= ========= Total master_lag: 0.29 =========