builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1456151176.54 results: success (0) buildid: 20160222030212 builduid: c4c5afe0268442618a2d2c650e205c99 revision: e1cf617a1f2813b6cd66f460313a61c223406c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.539717) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.540369) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.540683) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006699 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.610249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.610561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.705056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.705315) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004802 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.755539) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.755799) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.756140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.756424) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 06:26:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-02-22 06:26:17 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.936648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.937127) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013948 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:16.989500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:16.989818) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 06:26:17,161 truncating revision to first 12 chars 2016-02-22 06:26:17,161 Setting DEBUG logging. 2016-02-22 06:26:17,161 attempt 1/10 2016-02-22 06:26:17,161 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1cf617a1f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 06:26:18,395 unpacking tar archive at: mozilla-central-e1cf617a1f28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.530997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 06:26:18.534442) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.534776) ========= echo e1cf617a1f2813b6cd66f460313a61c223406c9b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1cf617a1f2813b6cd66f460313a61c223406c9b'] 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e1cf617a1f2813b6cd66f460313a61c223406c9b program finished with exit code 0 elapsedTime=0.003867 script_repo_revision: 'e1cf617a1f2813b6cd66f460313a61c223406c9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.583675) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.583970) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:18.593713) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-22 06:26:18.593995) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:18 INFO - MultiFileLogger online at 20160222 06:26:18 in /builds/slave/test-pgo 06:26:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:26:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:26:18 INFO - {'append_to_log': False, 06:26:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:26:18 INFO - 'blob_upload_branch': 'Firefox', 06:26:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:26:18 INFO - 'branch': 'Firefox', 06:26:18 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:18 INFO - 'config_files': ('talos/linux_config.py',), 06:26:18 INFO - 'default_actions': ('clobber', 06:26:18 INFO - 'read-buildbot-config', 06:26:18 INFO - 'download-and-extract', 06:26:18 INFO - 'populate-webroot', 06:26:18 INFO - 'create-virtualenv', 06:26:18 INFO - 'install', 06:26:18 INFO - 'run-tests'), 06:26:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:18 INFO - 'download_minidump_stackwalk': True, 06:26:18 INFO - 'download_symbols': 'ondemand', 06:26:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:18 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:18 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:18 INFO - 'installer_path': 'installer.exe', 06:26:18 INFO - 'log_level': 'info', 06:26:18 INFO - 'log_name': 'talos', 06:26:18 INFO - 'log_to_console': True, 06:26:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:18 INFO - 'opt_config_files': (), 06:26:18 INFO - 'pip_index': False, 06:26:18 INFO - 'sps_profile': False, 06:26:18 INFO - 'sps_profile_interval': 0, 06:26:18 INFO - 'suite': 'dromaeojs', 06:26:18 INFO - 'system_bits': '32', 06:26:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:18 INFO - 'title': 'talos-linux64-ix-050', 06:26:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:18 INFO - 'use_talos_json': True, 06:26:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:26:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:18 INFO - 'work_dir': 'build'} 06:26:18 INFO - ##### 06:26:18 INFO - ##### Running clobber step. 06:26:18 INFO - ##### 06:26:18 INFO - Running pre-action listener: _resource_record_pre_action 06:26:18 INFO - Running main action method: clobber 06:26:18 INFO - rmtree: /builds/slave/test-pgo/build 06:26:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:26:19 INFO - Running post-action listener: _resource_record_post_action 06:26:19 INFO - ##### 06:26:19 INFO - ##### Running read-buildbot-config step. 06:26:19 INFO - ##### 06:26:19 INFO - Running pre-action listener: _resource_record_pre_action 06:26:19 INFO - Running main action method: read_buildbot_config 06:26:19 INFO - Using buildbot properties: 06:26:19 INFO - { 06:26:19 INFO - "project": "", 06:26:19 INFO - "product": "firefox", 06:26:19 INFO - "script_repo_revision": "production", 06:26:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:26:19 INFO - "repository": "", 06:26:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:26:19 INFO - "buildid": "20160222030212", 06:26:19 INFO - "stage_platform": "linux64-pgo", 06:26:19 INFO - "basedir": "/builds/slave/test-pgo", 06:26:19 INFO - "nightly_build": "True", 06:26:19 INFO - "buildnumber": 198, 06:26:19 INFO - "slavename": "talos-linux64-ix-050", 06:26:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:26:19 INFO - "platform": "ubuntu64_hw", 06:26:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:26:19 INFO - "branch": "mozilla-central", 06:26:19 INFO - "repo_path": "mozilla-central", 06:26:19 INFO - "revision": "e1cf617a1f2813b6cd66f460313a61c223406c9b", 06:26:19 INFO - "pgo_build": "True", 06:26:19 INFO - "builduid": "c4c5afe0268442618a2d2c650e205c99", 06:26:19 INFO - "slavebuilddir": "test" 06:26:19 INFO - } 06:26:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:26:19 INFO - Running post-action listener: _resource_record_post_action 06:26:19 INFO - ##### 06:26:19 INFO - ##### Running download-and-extract step. 06:26:19 INFO - ##### 06:26:19 INFO - Running pre-action listener: _resource_record_pre_action 06:26:19 INFO - Running main action method: download_and_extract 06:26:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:19 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json 06:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json 06:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:26:19 INFO - Downloaded 1448 bytes. 06:26:19 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:26:19 INFO - Using the following test package requirements: 06:26:19 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:26:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:26:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'jsshell-linux-x86_64.zip'], 06:26:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:26:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:26:19 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:26:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:26:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 06:26:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 06:26:19 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:26:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:19 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:26:21 INFO - Downloaded 23366418 bytes. 06:26:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:22 INFO - Return code: 0 06:26:22 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:26:22 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')]} 06:26:22 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:26:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 06:26:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:26:24 INFO - Downloaded 23366418 bytes. 06:26:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:26 INFO - Return code: 0 06:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:26 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 06:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:26:27 INFO - Downloaded 10707015 bytes. 06:26:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:26:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 06:26:27 INFO - Return code: 0 06:26: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')]} 06:26:27 INFO - https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:26:28 INFO - Downloaded 56560179 bytes. 06:26:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:28 INFO - mkdir: /builds/slave/test-pgo/properties 06:26:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:26:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:26:28 INFO - Contents: 06:26:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 06:26:29 INFO - Running post-action listener: _resource_record_post_action 06:26:29 INFO - Running post-action listener: set_extra_try_arguments 06:26:29 INFO - ##### 06:26:29 INFO - ##### Running populate-webroot step. 06:26:29 INFO - ##### 06:26:29 INFO - Running pre-action listener: _resource_record_pre_action 06:26:29 INFO - Running main action method: populate_webroot 06:26:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:26:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:26:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:26:29 INFO - '--tppagecycles', 06:26:29 INFO - '7'], 06:26:29 INFO - 'tests': ['tsvgm']}}, 06:26:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:26:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:26:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:26:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:26:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'tests': ['damp', 'tps']}, 06:26:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['damp', 'tps']}, 06:26:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:26:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:26:29 INFO - 'other': {'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'other_l64': {'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'other_nol64': {'tests': ['a11yr', 06:26:29 INFO - 'ts_paint', 06:26:29 INFO - 'tpaint', 06:26:29 INFO - 'sessionrestore', 06:26:29 INFO - 'sessionrestore_no_auto_restore']}, 06:26:29 INFO - 'svgr': {'tests': ['tsvgx', 06:26:29 INFO - 'tsvgr_opacity', 06:26:29 INFO - 'tart', 06:26:29 INFO - 'tscrollx', 06:26:29 INFO - 'cart']}, 06:26:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['tsvgx', 06:26:29 INFO - 'tsvgr_opacity', 06:26:29 INFO - 'tart', 06:26:29 INFO - 'tscrollx', 06:26:29 INFO - 'cart']}, 06:26:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'tests': ['tp5o']}, 06:26:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'talos_options': ['--e10s'], 06:26:29 INFO - 'tests': ['tp5o']}, 06:26:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'talos_options': ['--xperf_path', 06:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:29 INFO - 'tests': ['tp5n']}, 06:26:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:26:29 INFO - 'talos_options': ['--e10s', 06:26:29 INFO - '--xperf_path', 06:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:29 INFO - 'tests': ['tp5n']}}, 06:26:29 INFO - 'talos.zip': {'path': '', 06:26:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:26:29 INFO - Running post-action listener: _resource_record_post_action 06:26:29 INFO - ##### 06:26:29 INFO - ##### Running create-virtualenv step. 06:26:29 INFO - ##### 06:26:29 INFO - Running pre-action listener: _resource_record_pre_action 06:26:29 INFO - Running main action method: create_virtualenv 06:26:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:26:29 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 06:26:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:26:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:26:29 INFO - Using real prefix '/usr' 06:26:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:26:30 INFO - Installing distribute.............................................................................................................................................................................................done. 06:26:32 INFO - Installing pip.................done. 06:26:32 INFO - Return code: 0 06:26:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:26:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:26:32 INFO - Using env: {'DISPLAY': ':0', 06:26:32 INFO - 'HOME': '/home/cltbld', 06:26:32 INFO - 'LANG': 'en_US.UTF-8', 06:26:32 INFO - 'LANGUAGE': 'en_US:en', 06:26:32 INFO - 'LOGNAME': 'cltbld', 06:26:32 INFO - 'MAIL': '/var/mail/cltbld', 06:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:32 INFO - 'MOZ_NO_REMOTE': '1', 06:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:32 INFO - 'NO_EM_RESTART': '1', 06:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:32 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:32 INFO - 'SHELL': '/bin/bash', 06:26:32 INFO - 'SHLVL': '1', 06:26:32 INFO - 'TERM': 'linux', 06:26:32 INFO - 'TMOUT': '86400', 06:26:32 INFO - 'USER': 'cltbld', 06:26:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:32 INFO - '_': '/tools/buildbot/bin/python'} 06:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:32 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 06:26:32 INFO - Cleaning up... 06:26:32 INFO - Return code: 0 06:26:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:26:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:26:32 INFO - Using env: {'DISPLAY': ':0', 06:26:32 INFO - 'HOME': '/home/cltbld', 06:26:32 INFO - 'LANG': 'en_US.UTF-8', 06:26:32 INFO - 'LANGUAGE': 'en_US:en', 06:26:32 INFO - 'LOGNAME': 'cltbld', 06:26:32 INFO - 'MAIL': '/var/mail/cltbld', 06:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:32 INFO - 'MOZ_NO_REMOTE': '1', 06:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:32 INFO - 'NO_EM_RESTART': '1', 06:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:32 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:32 INFO - 'SHELL': '/bin/bash', 06:26:32 INFO - 'SHLVL': '1', 06:26:32 INFO - 'TERM': 'linux', 06:26:32 INFO - 'TMOUT': '86400', 06:26:32 INFO - 'USER': 'cltbld', 06:26:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:32 INFO - '_': '/tools/buildbot/bin/python'} 06:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:32 INFO - Downloading/unpacking psutil>=0.7.1 06:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:26:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:34 INFO - Installing collected packages: psutil 06:26:34 INFO - Running setup.py install for psutil 06:26:34 INFO - building 'psutil._psutil_linux' extension 06:26:34 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 06:26:34 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 06:26:34 INFO - building 'psutil._psutil_posix' extension 06:26:34 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 06:26:34 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 06:26:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:34 INFO - Successfully installed psutil 06:26:34 INFO - Cleaning up... 06:26:34 INFO - Return code: 0 06:26:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:26:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:26:34 INFO - Using env: {'DISPLAY': ':0', 06:26:34 INFO - 'HOME': '/home/cltbld', 06:26:34 INFO - 'LANG': 'en_US.UTF-8', 06:26:34 INFO - 'LANGUAGE': 'en_US:en', 06:26:34 INFO - 'LOGNAME': 'cltbld', 06:26:34 INFO - 'MAIL': '/var/mail/cltbld', 06:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:34 INFO - 'MOZ_NO_REMOTE': '1', 06:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:34 INFO - 'NO_EM_RESTART': '1', 06:26:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:34 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:34 INFO - 'SHELL': '/bin/bash', 06:26:34 INFO - 'SHLVL': '1', 06:26:34 INFO - 'TERM': 'linux', 06:26:34 INFO - 'TMOUT': '86400', 06:26:34 INFO - 'USER': 'cltbld', 06:26:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:34 INFO - '_': '/tools/buildbot/bin/python'} 06:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:26:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:26:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:26:36 INFO - Installing collected packages: mozsystemmonitor 06:26:36 INFO - Running setup.py install for mozsystemmonitor 06:26:37 INFO - Successfully installed mozsystemmonitor 06:26:37 INFO - Cleaning up... 06:26:37 INFO - Return code: 0 06:26:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:26:37 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')]} 06:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:37 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')]} 06:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:37 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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:37 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 06:26:37 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 06:26:37 INFO - Using env: {'DISPLAY': ':0', 06:26:37 INFO - 'HOME': '/home/cltbld', 06:26:37 INFO - 'LANG': 'en_US.UTF-8', 06:26:37 INFO - 'LANGUAGE': 'en_US:en', 06:26:37 INFO - 'LOGNAME': 'cltbld', 06:26:37 INFO - 'MAIL': '/var/mail/cltbld', 06:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:37 INFO - 'MOZ_NO_REMOTE': '1', 06:26:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:37 INFO - 'NO_EM_RESTART': '1', 06:26:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:37 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:37 INFO - 'SHELL': '/bin/bash', 06:26:37 INFO - 'SHLVL': '1', 06:26:37 INFO - 'TERM': 'linux', 06:26:37 INFO - 'TMOUT': '86400', 06:26:37 INFO - 'USER': 'cltbld', 06:26:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:37 INFO - '_': '/tools/buildbot/bin/python'} 06:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:26:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:26:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:26:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:39 INFO - Downloading docopt-0.6.1.tar.gz 06:26:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:26:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:26:39 INFO - Running setup.py install for blobuploader 06:26:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:26:39 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:26:39 INFO - Running setup.py install for requests 06:26:40 INFO - Running setup.py install for docopt 06:26:40 INFO - Successfully installed blobuploader requests docopt 06:26:40 INFO - Cleaning up... 06:26:40 INFO - Return code: 0 06:26:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:40 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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:40 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 06:26:40 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 06:26:40 INFO - Using env: {'DISPLAY': ':0', 06:26:40 INFO - 'HOME': '/home/cltbld', 06:26:40 INFO - 'LANG': 'en_US.UTF-8', 06:26:40 INFO - 'LANGUAGE': 'en_US:en', 06:26:40 INFO - 'LOGNAME': 'cltbld', 06:26:40 INFO - 'MAIL': '/var/mail/cltbld', 06:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:40 INFO - 'MOZ_NO_REMOTE': '1', 06:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:40 INFO - 'NO_EM_RESTART': '1', 06:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:40 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:40 INFO - 'SHELL': '/bin/bash', 06:26:40 INFO - 'SHLVL': '1', 06:26:40 INFO - 'TERM': 'linux', 06:26:40 INFO - 'TMOUT': '86400', 06:26:40 INFO - 'USER': 'cltbld', 06:26:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:40 INFO - '_': '/tools/buildbot/bin/python'} 06:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:40 INFO - Running setup.py (path:/tmp/pip-89fWpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:40 INFO - Running setup.py (path:/tmp/pip-ruYhKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:40 INFO - Running setup.py (path:/tmp/pip-a6K4Jn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:40 INFO - Running setup.py (path:/tmp/pip-6mBXZV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:40 INFO - Running setup.py (path:/tmp/pip-EsCjXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:41 INFO - Running setup.py (path:/tmp/pip-PlXh_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:41 INFO - Running setup.py (path:/tmp/pip-zVbpud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:41 INFO - Running setup.py (path:/tmp/pip-rwiPuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:41 INFO - Running setup.py (path:/tmp/pip-D_vsoo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:41 INFO - Running setup.py (path:/tmp/pip-5QR67K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:41 INFO - Running setup.py (path:/tmp/pip-F7TbYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:41 INFO - Running setup.py (path:/tmp/pip-s47CkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:41 INFO - Running setup.py (path:/tmp/pip-kHjmy2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:41 INFO - Running setup.py (path:/tmp/pip-tijGmy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:41 INFO - Running setup.py (path:/tmp/pip-isZGYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:41 INFO - Running setup.py (path:/tmp/pip-P_ELfn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:41 INFO - Running setup.py (path:/tmp/pip-MFyeHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:26:41 INFO - Running setup.py install for manifestparser 06:26:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for mozcrash 06:26:42 INFO - Running setup.py install for mozdebug 06:26:42 INFO - Running setup.py install for mozdevice 06:26:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for mozfile 06:26:42 INFO - Running setup.py install for mozhttpd 06:26:42 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for mozinfo 06:26:42 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for mozInstall 06:26:42 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for mozleak 06:26:42 INFO - Running setup.py install for mozlog 06:26:42 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:26:42 INFO - Running setup.py install for moznetwork 06:26:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozprocess 06:26:43 INFO - Running setup.py install for mozprofile 06:26:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozrunner 06:26:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Running setup.py install for mozscreenshot 06:26:43 INFO - Running setup.py install for moztest 06:26:43 INFO - Running setup.py install for mozversion 06:26:43 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:26:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:26:43 INFO - Cleaning up... 06:26:43 INFO - Return code: 0 06:26:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26: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')]} 06:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26: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')]} 06:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:43 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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:43 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 06:26:43 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 06:26:43 INFO - Using env: {'DISPLAY': ':0', 06:26:43 INFO - 'HOME': '/home/cltbld', 06:26:43 INFO - 'LANG': 'en_US.UTF-8', 06:26:43 INFO - 'LANGUAGE': 'en_US:en', 06:26:43 INFO - 'LOGNAME': 'cltbld', 06:26:43 INFO - 'MAIL': '/var/mail/cltbld', 06:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:43 INFO - 'MOZ_NO_REMOTE': '1', 06:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:43 INFO - 'NO_EM_RESTART': '1', 06:26:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:43 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:43 INFO - 'SHELL': '/bin/bash', 06:26:43 INFO - 'SHLVL': '1', 06:26:43 INFO - 'TERM': 'linux', 06:26:43 INFO - 'TMOUT': '86400', 06:26:43 INFO - 'USER': 'cltbld', 06:26:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:43 INFO - '_': '/tools/buildbot/bin/python'} 06:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:43 INFO - Running setup.py (path:/tmp/pip-Jt3zaJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:44 INFO - Running setup.py (path:/tmp/pip-EIZcth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:44 INFO - Running setup.py (path:/tmp/pip-oCOqRa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:44 INFO - Running setup.py (path:/tmp/pip-I8LKgO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:44 INFO - Running setup.py (path:/tmp/pip-Gz8uXC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:44 INFO - Running setup.py (path:/tmp/pip-rzT3PF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:44 INFO - Running setup.py (path:/tmp/pip-jj3dgU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:44 INFO - Running setup.py (path:/tmp/pip-kgFJlw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:44 INFO - Running setup.py (path:/tmp/pip-ntZBUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:44 INFO - Running setup.py (path:/tmp/pip-ma5I8Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:44 INFO - Running setup.py (path:/tmp/pip-ko1GEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:44 INFO - Running setup.py (path:/tmp/pip-DiLWFr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:44 INFO - Running setup.py (path:/tmp/pip-aTrbsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:26:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:44 INFO - Running setup.py (path:/tmp/pip-kUnfYo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:26:44 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)) 06:26:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:44 INFO - Running setup.py (path:/tmp/pip-fHyw8A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:45 INFO - Running setup.py (path:/tmp/pip-YKYxmZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:26:45 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)) 06:26:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:45 INFO - Running setup.py (path:/tmp/pip-KhMkLx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:26:45 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)) 06:26:45 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)) 06:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 06:26:45 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)) 06:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:26:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:46 INFO - Downloading blessings-1.6.tar.gz 06:26:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:26:47 INFO - Installing collected packages: blessings 06:26:47 INFO - Running setup.py install for blessings 06:26:47 INFO - Successfully installed blessings 06:26:47 INFO - Cleaning up... 06:26:47 INFO - Return code: 0 06:26:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:26:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:26:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:26:47 INFO - Reading from file tmpfile_stdout 06:26:47 INFO - Current package versions: 06:26:47 INFO - argparse == 1.2.1 06:26:47 INFO - blessings == 1.6 06:26:47 INFO - blobuploader == 1.2.4 06:26:47 INFO - docopt == 0.6.1 06:26:47 INFO - manifestparser == 1.1 06:26:47 INFO - mozInstall == 1.12 06:26:47 INFO - mozcrash == 0.16 06:26:47 INFO - mozdebug == 0.1 06:26:47 INFO - mozdevice == 0.48 06:26:47 INFO - mozfile == 1.2 06:26:47 INFO - mozhttpd == 0.7 06:26:47 INFO - mozinfo == 0.9 06:26:47 INFO - mozleak == 0.1 06:26:47 INFO - mozlog == 3.1 06:26:47 INFO - moznetwork == 0.27 06:26:47 INFO - mozprocess == 0.22 06:26:47 INFO - mozprofile == 0.28 06:26:47 INFO - mozrunner == 6.11 06:26:47 INFO - mozscreenshot == 0.1 06:26:47 INFO - mozsystemmonitor == 0.0 06:26:47 INFO - moztest == 0.7 06:26:47 INFO - mozversion == 1.4 06:26:47 INFO - psutil == 3.1.1 06:26:47 INFO - requests == 1.2.3 06:26:47 INFO - wsgiref == 0.1.2 06:26:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:47 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 06:26:47 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 06:26:47 INFO - Using env: {'DISPLAY': ':0', 06:26:47 INFO - 'HOME': '/home/cltbld', 06:26:47 INFO - 'LANG': 'en_US.UTF-8', 06:26:47 INFO - 'LANGUAGE': 'en_US:en', 06:26:47 INFO - 'LOGNAME': 'cltbld', 06:26:47 INFO - 'MAIL': '/var/mail/cltbld', 06:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:47 INFO - 'MOZ_NO_REMOTE': '1', 06:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:47 INFO - 'NO_EM_RESTART': '1', 06:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:47 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:47 INFO - 'SHELL': '/bin/bash', 06:26:47 INFO - 'SHLVL': '1', 06:26:47 INFO - 'TERM': 'linux', 06:26:47 INFO - 'TMOUT': '86400', 06:26:47 INFO - 'USER': 'cltbld', 06:26:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:47 INFO - '_': '/tools/buildbot/bin/python'} 06:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:26:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:26:47 INFO - Cleaning up... 06:26:47 INFO - Return code: 0 06:26:47 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:47 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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:47 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 06:26:47 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 06:26:47 INFO - Using env: {'DISPLAY': ':0', 06:26:47 INFO - 'HOME': '/home/cltbld', 06:26:47 INFO - 'LANG': 'en_US.UTF-8', 06:26:47 INFO - 'LANGUAGE': 'en_US:en', 06:26:47 INFO - 'LOGNAME': 'cltbld', 06:26:47 INFO - 'MAIL': '/var/mail/cltbld', 06:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:47 INFO - 'MOZ_NO_REMOTE': '1', 06:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:47 INFO - 'NO_EM_RESTART': '1', 06:26:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:47 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:47 INFO - 'SHELL': '/bin/bash', 06:26:47 INFO - 'SHLVL': '1', 06:26:47 INFO - 'TERM': 'linux', 06:26:47 INFO - 'TMOUT': '86400', 06:26:47 INFO - 'USER': 'cltbld', 06:26:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:47 INFO - '_': '/tools/buildbot/bin/python'} 06:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:47 INFO - Downloading/unpacking jsonschema 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26: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 06:26:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:26:49 INFO - Downloading/unpacking functools32 (from jsonschema) 06:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:49 INFO - Downloading functools32-3.2.3-2.tar.gz 06:26:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:26:49 INFO - warning: no files found matching '*.txt' 06:26:49 INFO - no previously-included directories found matching 'build' 06:26:49 INFO - no previously-included directories found matching 'dist' 06:26:49 INFO - no previously-included directories found matching '.git*' 06:26:49 INFO - Installing collected packages: jsonschema, functools32 06:26:49 INFO - Running setup.py install for functools32 06:26:50 INFO - warning: no files found matching '*.txt' 06:26:50 INFO - no previously-included directories found matching 'build' 06:26:50 INFO - no previously-included directories found matching 'dist' 06:26:50 INFO - no previously-included directories found matching '.git*' 06:26:50 INFO - Successfully installed jsonschema functools32 06:26:50 INFO - Cleaning up... 06:26:50 INFO - Return code: 0 06:26:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:26:50 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')]} 06:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:50 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')]} 06:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:26:50 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 0x7f04c92fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, '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': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', '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 06:26:50 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 06:26:50 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 06:26:50 INFO - Using env: {'DISPLAY': ':0', 06:26:50 INFO - 'HOME': '/home/cltbld', 06:26:50 INFO - 'LANG': 'en_US.UTF-8', 06:26:50 INFO - 'LANGUAGE': 'en_US:en', 06:26:50 INFO - 'LOGNAME': 'cltbld', 06:26:50 INFO - 'MAIL': '/var/mail/cltbld', 06:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:50 INFO - 'MOZ_NO_REMOTE': '1', 06:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:50 INFO - 'NO_EM_RESTART': '1', 06:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:26:50 INFO - 'PWD': '/builds/slave/test-pgo', 06:26:50 INFO - 'SHELL': '/bin/bash', 06:26:50 INFO - 'SHLVL': '1', 06:26:50 INFO - 'TERM': 'linux', 06:26:50 INFO - 'TMOUT': '86400', 06:26:50 INFO - 'USER': 'cltbld', 06:26:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:50 INFO - '_': '/tools/buildbot/bin/python'} 06:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:50 INFO - Downloading/unpacking flake8 06:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:26:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:26:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 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 06:26:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:26:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:52 INFO - no previously-included directories found matching 'docs/_build' 06:26:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:26:52 INFO - Running setup.py install for pep8 06:26:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:26:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:26:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:26:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:26:52 INFO - no previously-included directories found matching 'docs/_build' 06:26:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:26:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:26:53 INFO - Cleaning up... 06:26:53 INFO - Return code: 0 06:26:53 INFO - Running post-action listener: _resource_record_post_action 06:26:53 INFO - Running post-action listener: _start_resource_monitoring 06:26:53 INFO - Starting resource monitoring. 06:26:53 INFO - ##### 06:26:53 INFO - ##### Running install step. 06:26:53 INFO - ##### 06:26:53 INFO - Running pre-action listener: _resource_record_pre_action 06:26:53 INFO - Running main action method: install 06:26:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:26:53 INFO - Reading from file tmpfile_stdout 06:26:53 INFO - Detecting whether we're running mozinstall >=1.0... 06:26:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:26:53 INFO - Reading from file tmpfile_stdout 06:26:53 INFO - Output received: 06:26:53 INFO - Usage: mozinstall [options] installer 06:26:53 INFO - Options: 06:26:53 INFO - -h, --help show this help message and exit 06:26:53 INFO - -d DEST, --destination=DEST 06:26:53 INFO - Directory to install application into. [default: 06:26:53 INFO - "/builds/slave/test-pgo"] 06:26:53 INFO - --app=APP Application being installed. [default: firefox] 06:26:53 INFO - mkdir: /builds/slave/test-pgo/build/application 06:26:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:26:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:27:09 INFO - Reading from file tmpfile_stdout 06:27:09 INFO - Output received: 06:27:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:27:09 INFO - Running post-action listener: _resource_record_post_action 06:27:09 INFO - ##### 06:27:09 INFO - ##### Running run-tests step. 06:27:09 INFO - ##### 06:27:09 INFO - Running pre-action listener: _resource_record_pre_action 06:27:09 INFO - Running main action method: run_tests 06:27:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:27:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:27:09 INFO - Python 2.7.3 06:27:09 INFO - Return code: 0 06:27:09 INFO - grabbing minidump binary from tooltool 06:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:09 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 0x11628c0>, '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 0x11637c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1163c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:27:09 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 06:27:09 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 06:27:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:27:09 INFO - Return code: 0 06:27:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:27:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:27:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:27:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:27:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:27:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:27:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:27:10 INFO - Return code: 0 06:27:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:27:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:27:10 INFO - Using env: {'DISPLAY': ':0', 06:27:10 INFO - 'HOME': '/home/cltbld', 06:27:10 INFO - 'LANG': 'en_US.UTF-8', 06:27:10 INFO - 'LANGUAGE': 'en_US:en', 06:27:10 INFO - 'LOGNAME': 'cltbld', 06:27:10 INFO - 'MAIL': '/var/mail/cltbld', 06:27:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:27:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:10 INFO - 'MOZ_NO_REMOTE': '1', 06:27:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:27:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:10 INFO - 'NO_EM_RESTART': '1', 06:27:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:27:10 INFO - 'PWD': '/builds/slave/test-pgo', 06:27:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:27:10 INFO - 'SHELL': '/bin/bash', 06:27:10 INFO - 'SHLVL': '1', 06:27:10 INFO - 'TERM': 'linux', 06:27:10 INFO - 'TMOUT': '86400', 06:27:10 INFO - 'USER': 'cltbld', 06:27:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825', 06:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:10 INFO - '_': '/tools/buildbot/bin/python'} 06:27:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:27:10 INFO - mozversion application_buildid: 20160222030212 06:27:10 INFO - mozversion application_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:10 INFO - mozversion application_display_name: Nightly 06:27:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:27:10 INFO - mozversion application_name: Firefox 06:27:10 INFO - mozversion application_remotingname: firefox 06:27:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:27:10 INFO - mozversion application_vendor: Mozilla 06:27:10 INFO - mozversion application_version: 47.0a1 06:27:10 INFO - mozversion platform_buildid: 20160222030212 06:27:10 INFO - mozversion platform_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:27:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:27:10 INFO - mozversion platform_version: 47.0a1 06:27:10 INFO - using testdate: 1456151230 06:27:10 INFO - actual date: 1456151230 06:27:11 INFO - starting webserver on 'localhost:44083' 06:27:11 INFO - SUITE-START | Running 2 tests 06:27:11 INFO - TEST-START | dromaeo_css 06:27:11 INFO - operating with platform_type : linux_ 06:27:11 INFO - Initialising browser for dromaeo_css test... 06:27:11 INFO - TEST-INFO | started process 6063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTO9Ops/profile http://localhost:44083/getInfo.html) 06:27:15 INFO - PROCESS | 6063 | __metrics Screen width/height:1600/1200 06:27:15 INFO - PROCESS | 6063 | colorDepth:24 06:27:15 INFO - PROCESS | 6063 | Browser inner width/height: 1024/697 06:27:15 INFO - PROCESS | 6063 | __metrics 06:27:16 INFO - PROCESS | 6063 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:27:16 INFO - TEST-INFO | 6063: exit 0 06:27:16 INFO - Browser initialized. 06:27:16 INFO - Running cycle 1/1 for dromaeo_css test... 06:27:16 INFO - TEST-INFO | started process 6158 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTO9Ops/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:28 INFO - PROCESS | 6158 | RSS: Main: 148025344 06:27:28 INFO - PROCESS | 6158 | 06:28:20 INFO - PROCESS | 6158 | 1456151300116 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] 06:30:28 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44083/tests/dromaeo/cssquery-ext.html) 06:30:28 INFO - PROCESS | 6158 | RSS: Main: 205979648 06:30:28 INFO - PROCESS | 6158 | 06:33:31 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-ext.html (next: http://localhost:44083/tests/dromaeo/cssquery-jquery.html) 06:33:31 INFO - PROCESS | 6158 | RSS: Main: 237887488 06:33:31 INFO - PROCESS | 6158 | 06:36:34 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44083/tests/dromaeo/cssquery-mootools.html) 06:36:34 INFO - PROCESS | 6158 | RSS: Main: 227282944 06:36:34 INFO - PROCESS | 6158 | 06:39:36 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44083/tests/dromaeo/cssquery-prototype.html) 06:39:37 INFO - PROCESS | 6158 | RSS: Main: 216686592 06:39:37 INFO - PROCESS | 6158 | 06:42:39 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44083/tests/dromaeo/cssquery-yui.html) 06:42:40 INFO - PROCESS | 6158 | RSS: Main: 190234624 06:42:40 INFO - PROCESS | 6158 | 06:45:42 INFO - PROCESS | 6158 | Cycle 1(1): loaded http://localhost:44083/tests/dromaeo/cssquery-yui.html (next: http://localhost:44083/tests/dromaeo/cssquery-dojo.html) 06:45:43 INFO - PROCESS | 6158 | RSS: Main: 281440256 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | __start_tp_report 06:45:43 INFO - PROCESS | 6158 | _x_x_mozilla_page_load 06:45:43 INFO - PROCESS | 6158 | _x_x_mozilla_page_load_details 06:45:43 INFO - PROCESS | 6158 | |i|pagename|runs| 06:45:43 INFO - PROCESS | 6158 | |0;dojo.html;3132.3578666373396;3146.402183585117;3201.599800024997;3204.503301988191;3234.9676503234973;4995.75021248937;5082.186850103984;5149.1503901856195;5187.507186817251;5215.608829337796;5061.6709913855575;5130.846074617758;5222.817201397952;5235.1885457754015;5251.947480525194;4650.302454631816;4662.650301227413;4672.0889426561835;4677.766111694402;4839.05638400512;4680.882977925562;4768.73771942543;4780.856574302777;4792.424909010923;4837.588804951583;4727.598154156901;4739.786709598076;4753.548412900769;4756.7145971241835;4807.783649735753;4800.639952003578;4812.879678008043;4818.060478206716;4818.204996175627;4822.758862056883;4645.976770116128;4791.233402655594;4799.688020278671;4800.615950723969;4859.659823812334;5117.974410127963;5139.640225184238;5139.794408223666;5148.974255128738;5149.485051494858;5656.688882111483;5660.150977353389;5660.377358490604;5668.461496157858;5716.542676585905;5516.393196748354;5657.660540367591;5729.341125770548;5747.971260143672;5791.594588378815;5238.685678859242;5251.264822924793;5252.868678283074;5261.5264626183825;5267.209918512215;5622.297212848394;5688.488036076773;5694.259746232963;5703.230063941398;5715.257016587817;5501.229827824108;5532;5534.1975413565615;5544.750486228129;5577.358603760619;5623.100303951348;5632.662040277596;5636.126400407861;5641.8589535261945;5654.491095801398;5440.455954404607;5465;5529.976954263474;5569.164625306155;5620.100783874561;5508.118701007819;5511.669299842022;5526;5538.9169162462595;5551.611387202938;4247.723897946686;4304.139172165516;4322.8703138905885;4328.523862375137;4346.413234213404;3876.4185372194397;3916.2950668879876;3921;3929.390944403622;3935.803209839554;5249.501297376743;5288.867778305573;5305.076874678582;5320.388155362183;5352.170413585901;5551.333839939233;5601;5673.31920169574;5674.858128546819;5680.687562184037;5201.713905735221;5205.895882082337;5221.008008478377;5225.921611175835;5237.764300606482;4814.109389762905;4815.879603009883;4818.6626936114135;4820.084184005028;4844.249141383091;5486.341639003345;5880.059190529495;5893.381194974551;5894.587378883437;5944.910826337608;5561.721913904208;5565.972170139124;5580.5535557156145;5587.161925711013;5591.217229587943;5648.85877853057;5779.479846813807;5784.5083167929515;5811;5820.650760954356;5516.779328826802;5533.889322213614;5551.944480555304;5557.221988921473;5566.638168519034;5608.130739735348;5619.943800561942;5620.072688006433;5624.803131890528;5626.465485778845;5302.814401495929;5429.457054294539;5467.234587157881;5492.121260598445;5518.751656175402;5398.406175320633;5432.266644003009;5439.891202176013;5441;5445.754941027584;5251.52736253739;5389.649672771257;5397.70312632809;5402.459754024566;5444.455554444524;5458.344998600193;5478.808241711521;5494.478024587658;5506.256655351476;5544.390117087198;5153.896922061613;5331.813386531453;5345.866353341197;5400.378956419905;5455.1271796512365 06:45:43 INFO - PROCESS | 6158 | |1;ext.html;528.0310629993961;531.968081915085;554.2379228560726;556.5964675610181;557.9246801681771;36850.631493685054;37396.81301593488;37460.25397460253;37478.437823432636;37513.24973500528;37209;37266;37557.81221093891;37627.43558846619;37786;8349.62426690799;8552.016518100436;8568.314534837198;8574.44266122703;8574.528400937947;8415;8773.473591584525;8789.252913502329;8791.692290769824;8792.164744349277;8713.346499012569;8758.693445729368;8771.342149338794;8788.69239576615;8799.032106468283;8671.523066231355;8727.127287271285;8732.12678732128;8747.868781968276;8763.824723505559;8633.352498562634;8751.868721969175;8756.255718263956;8756.474611523328;8758.386912916098;36243;36711.53153873842;36746.632533674856;36760.26479470422;36818.263634727155;2428.9434096168225;3233.2563510392506;3305.5041743738393;3333.3000069985333;3420.521127042216;27331.316717082034;27353.589696154573;27538.449231015467;27601.447971040667;27602.309942251402;3807.866724664651;3831.7892515911612;3900.609191818705;3909.061825161969;3921.392184211452;273229;276353;277572;277662;368723;62829.68585157045;64172;64293;64307.35692643013;64425;56400.71799640975;56553.71723141358;56695;56752.71623641856;56791;15374.154421506924;15520.611984700472;15539;15572.143532105843;15624.062556246661;11537;11675.182737208484;11741.589044383405;11812.586559470377;11849.881501184878;20531.38405847827;20756;20875.58248835045;20937.162513499596;20962.790372096082;8074.475159114639;8173.305269052078;8177.177147292722;8246;8258.793530161794;885.2608072259607;915.9633614655472;917.6375331744057;933.7992331648728;1063.9148868090533;25585.8720706399;26301.73698262993;26314.342141446617;26393.20820375392;30463;967.9806403872024;992.5533509920565;1030.21703505335;1059.4637775225954;1092.9726057505918;14302.57092287233;14403.135811851322;14419.711605767827;14601.561953141423;14700.264986750619;363317;366029;366151;366935;366975;54394.45605543973;54437.72781136148;54462.18306725402;54469;54510.727446362514;1277.923324600527;1359.7620416427085;1368.3500337339683;1374.8900087992936;1378.2488543743684;30569;31049;31499.37001259916;32358.514622280214;33038.17404564905;45932;46046.76976615095;46516.30225546552;46536;46593;221086;224380;294468;302856;309080;38237.235255295294;39142.23859926367;42118;43050;43547.34678979881;38696.613033869304;39298.63679120893;39554;39838.203235935696;40019.79990100031;33643;33687.494687579216;34001.14997125092;34088.48867267043;34290.314193716484;33168.66831331656;33544;35205.82397087998;37434.25131497409;38454;33928.15179620431;34188;34247.486287706204;38563.421548677354;39063.609363906;29550;33458.33083338368;34502.30995380128;34513.75660582054;35313.64686353104;25387.492250155265;25460;25612.615810763225;25644.358891027874;25942.092026778973 06:45:43 INFO - PROCESS | 6158 | |2;jquery.html;352.8412214503474;359.6331741623544;361.8317482370697;363.1792149741584;365.6161030917536;13847.930760346184;16436.67126657466;16789.49631511055;16994.235259413326;17609.64780704385;15842.445514406998;16158.192090395492;16191.919040404811;16309.59226019347;16425.58936026597;5332.33345831771;5414.83755487336;5460.399356070829;5471.398146203935;5513.255710479094;4010.6390424861756;4148.419221309019;4155.127423241123;5271.42014378418;5975.641461512301;6109.755609775626;6128.540359473035;6148.108524263979;6149.385061493837;6150.569460137792;5991.430814072656;6143.232095988002;6149.5080393568405;6156.322804491502;6209.968950155243;5363.463653634644;5371.355437347544;5397.568194544467;5401.162819762943;5421.566274698054;19969.400917972485;20667.689984650242;20854.791452085436;20859.895700521552;20872;2129.595376878388;2149.50561370884;2251.8761468119246;2321.048370168223;2541.3519552514176;9440.2919781016;9869.85195222065;12989.935050324782;13180.736385272337;13482.730345393134;1763.2770564068671;1788.1148831328446;1792.2920446423589;1831.716084006981;1835.9082045897785;62212;63437;63454.385473743445;63881;64202.67898660477;10478.109360704426;10517.737056573647;10547.630832920811;10558.788824223626;10570.630027948984;13851.684090011433;13940.512082077079;13952.58142255734;13956.371963261678;13995;7846.725364612325;7875.369970402354;7886.960565197137;7917.485363451472;7918.2477664621765;7507.549547027086;7563.584002879785;7612.505187162817;7631.503952243086;7645.808854778675;4466;4556.88607784808;4566.634669226454;4600.631949444037;4617.884552886205;1731.5195507840867;1753.6405036967392;1769.9026553539422;1801.1174524482908;1809.2129923483326;434.5372178629749;436.47622852577035;904.5658084119527;971.6890595009529;987.6641941739842;10162.339447935861;10533.894661053291;10806.135509159249;11079.335239885633;11306.717332066764;446.48877035793834;478.3327258474409;489.9853004409873;494.16486138425944;512.0348143748986;5999.610025348338;6128;6254.530910181755;6264.968675156595;6278.183836101278;250428;282614;349438;408553;435647;65500.672496638166;72968.27031729615;75482.62258688781;75589;77424.61287693639;436.8274531560016;452.12965042293456;452.4073463762416;455.59224494077614;457.2250036188695;10042;10496.52765625564;10592.576296948344;10721.641238927423;10820.458977051274;33741;33860.49209261814;34382.484262735576;34568.48147277743;34604;46220.537794621625;46579.767101164274;46955.53044469511;47514.76242618903;47736.28395574;7709.383249340151;7832.138464768757;7935.1271360149185;8044.436889417919;8183.8772418414965;10165.288429809842;10622.468876555986;12024.33866137371;12232.143749937419;12305.077119215915;9973.800523989334;9993;10022.799544008933;10026.749331266485;10126.949365253127;10200.693979180636;10293.691189264335;10319.174466042849;10448.2163837714;10504.947475262881;10080.647177348757;10368.533415996148;10410.47947602632;10506.264561480622;10613.363198208132;7733.110692270461;7875.251851074138;7878.724244651639;8050.758477245692;8101.311388532041;10313.845292320471;10319.329243599143;10325.432101234504;10466.476676166314;10556.313839600401 06:45:43 INFO - PROCESS | 6158 | |3;mootools.html;1310.88857447117;1474.0713350589128;1491.5152575412988;1604.7352186889163;1735.1150913034348;7522.699092036319;7707.267809558097;7717.652705628247;7733.7293194738195;7742.651580678869;7566.167721550625;7711.730089446871;7717.266859648338;7748.883766743489;7752.961235193816;1975.6147551227516;2029.5027718208985;2303.2284184798114;2321.1411777642297;2330.7436182019965;2339.344983404641;2347.366211122996;2349.600567903452;2350.165691179632;2352.0356653771955;2231.966520502194;2283.4976305212826;2287.1994801819396;2289.2559918026623;2290.5533420982915;2239.708837851077;2281.6577513372963;2326.6161083421216;2330.790228879392;2338.9181378651665;2296.494771150344;2305.8501197422115;2325.197806756666;2325.383773300077;2339.02930283932;7884.64519096642;7936.285734283884;7949.801254968615;7952.880706789403;7953.284204421572;4832.806687732486;4919.950800491985;4951.529604687549;4953.306537084811;4956.677815941988;3223.4358987177384;3268.0686004488844;3332.266901281714;3335.7331413486863;3344.2308269098;1107.213878146517;1110.9777804443947;1122.1639878290725;1134.0417347341483;1147.4549588945267;10960.890391096067;11046.33721976676;11049;11051.502682379232;11060.778784424347;4350.347447882779;4362.563743625612;4421.756803375845;4423.778811059498;4456.24243878535;9385.436873787594;9396.295277854188;9404.764880878032;9419.24646028316;9419.340646154704;4263.914721705549;4856.344393506832;4895.510448955076;4899.755012249373;4904.141775189328;3885.1258466844733;4199.076203235283;4260.275753121977;4262.616364527207;4273.9358909616385;3694.649008344203;3696.242270334575;3701.777893326409;3738.551373835103;3747.1568896997956;1178.3401295274673;1182.3851597169423;1190.36315571169;1195.6771671648605;1203.2599951030054;1315.3620494060374;1321.9074664773566;1340.6112227454123;1361.5302720561588;1367.466687991684;7419.07261592301;7566.659500322388;7568.848623027508;7617.6572054257695;7620.657070431844;507.3632591098148;510.5481648740817;517.7877070401117;519.3300642171632;522.5206395652652;5705.429457054262;5739.713014349266;5749.310082790092;5775.855603609859;5776.191333213354;9022.14289642483;9714.125728684452;9815.509224538744;9839.311248212556;9850;9622;9653.22774178064;9662.516874156265;9671.758206044764;9693.854592181124;7216.422686185093;7523.210062943313;7546.132194797558;7548.698052077855;7670.616469176519;7203.71185152588;7212.3148300911325;7271.345578897713;7282.526635768658;7283.781486555412;8532.104129066358;8647.437916535406;8702.738917832476;8790.42862213954;8793.868091978498;8736.563171841255;8873.73378798637;8896.777580560538;9072.818543629222;9106.590203440728;5999.310079340931;6154.9384506154365;6156.384361563987;7046.26014268515;7114.181869085121;7234.385077268491;7419.9258007421395;7444.218357072646;7449.366803821736;7449.7020119196795;6614.272430032789;6720.899186512109;6740.056392105012;6810.31896810315;6854.554453960476;6792.388685018372;6827.21487028998;6842.24735279109;6885.449164066963;6950.721971121098;7004;7096.787096387116;7130.18002929649;7144.3212894774915;7148.535345202546;6570.77002304917;6598.472122230114;6621.1392518972225;6624.536282460182;6638.269790323157;6666.966665166643;6709.7651582194385;6718.697658605277;6718.764843230463;6720.764773232913 06:45:43 INFO - PROCESS | 6158 | |4;prototype.html;322.78534774375044;330.85607760624123;332.5909131767924;333.3017328696381;333.9031282237848;5684.630499017561;5752.137179423078;5812.854678633036;5816.651000939942;5899.911501327478;5775.884482310351;5806.564507661932;5821.3887541808135;5828.562857785672;5859.941400585993;4575.656825738083;4575.771211439414;4577.496475387705;4580.954190458103;4582.03777206787;4338.97830510847;4453.042595841894;4522.773861306938;4543.795529201194;4585.220512512864;4474.932876006863;4481.305397663367;4483.5516448355065;4491.6182124519455;4518.819247230107;4522.050369422442;4528.18492671319;4531.252343363341;4538.682292239545;4540.091981603659;4015;4017.1563971566006;4020.2361551305157;4025.798710064514;4029.37544680575;5617;5622.91565626516;5623.971880140614;5628.746706398222;5630.634008789416;5252.715068945021;5261.447548007481;5265.947340526623;5274.705503106123;5275.208718692188;5907.291125064977;6104.481119104837;6133.1413602095745;6140.171076904606;6150.96924515379;4298.032942587924;4298.527162012176;4302.204092242914;4302.698811083225;4303.397524346594;6275.96862015687;6373.235211774617;6455.386738259858;6494.512911531607;6503.089567460606;4392.714473559208;4412.161689279027;4413.624841888475;4414.602685758297;4425.336199570026;4465.1962646723905;4465.709728867613;4469.41897553316;4476.574725401082;4477.1269602427865;5158.92261616076;5165.767540460688;5167.0957582422925;5168.689878607295;5183.015227106837;5957.851053723692;6031.577789554777;6200.627962322184;6209.96895015531;6222.066689996446;1608.806943166804;1620.173711407191;1626.6421387294777;1627.6744651069832;1633.2650307361735;1083.1767856429012;1097.9341239525654;1099.5491848342142;1101.3832253937821;1132.994335028336;5897.144913987534;5901.701625642352;5903.734331954986;5904.704764761831;5914.290285165807;6381.8723625528155;6387.137736405526;6389.274895778114;6389.456896163785;6393.648349340738;5842.474177324061;5892.882142357129;5897.469227769436;5905.4685078343155;5908.084246941731;3406.454967205285;3445.707114895212;3446.8965931022108;3449.6032956209856;3452.7065199457825;6411.967940160363;6667.86664266712;6669.266380698119;6675.499337549703;6749.8650026999185;6587.374199451045;6619.635920024445;6622.437092847162;6626.503012274099;6634.900476492857;6697.866042679217;6703.12859328294;6708.597484150967;6718.395344419026;6720.731170753213;6409.743610255724;6416.550841441054;6416.871662566816;6417.48660107181;6422.743090276336;6153.507719382528;6308.684565771785;6322.841928951813;6330.987042073246;6340.1123842661145;6674.733010679518;6679.732810687518;6694.4644428444635;6698.866022679422;6709.329067093252;4380.5838445347645;4417.690761646782;4420.071784925201;4422.049259409242;4422.270325396274;6173.876522469435;6306.65313407767;6420.165378500765;6426.132472116205;6428.132202152649;6259.593126446766;6267.2479302484;6273.435390814849;6284.5600807943;6286.842828929313;6266.467350275096;6267.122602835698;6276.089966954674;6279.780207692709;6280.466160376419;6108.419700128481;6157.230346206724;6163.106349579376;6171.382861713792;6187.907181392373;6125.724342404514;6287.46556542699;6292.968535157295;6299.653519056313;6299.992001279773;6117.174181485442;6121.051237058263;6127.3259941407305;6144.262688477412;6165.013597824506 06:45:43 INFO - PROCESS | 6158 | |5;yui.html;697.2539382860339;709.6912842913337;725.9854802903942;820.9712660056899;827.9710210142646;13811.654708632277;13968;14005.719885602282;14029.088109272903;14041;13324.533641322556;13385.79921301179;13465.932670336659;14415.063020903634;14472.131672099682;806.2542148512632;806.4637016384127;811.5212024905304;814.360726829439;815.4332738746574;794.2732399854126;806.1857523900844;807.1283014344494;809.017044291186;812.3704129299781;840.487302745328;851.1403482482706;851.9105493923141;853.1809462915609;853.7780177153923;844.0462277626274;847.1147650704967;847.7329641163014;849.6049337058236;850.961706723199;625.0592857749104;625.5183508698323;625.8216408323606;627.7175271127965;628.475223188638;12862.906652934511;12894.097413181082;12919.870801292054;12931.935340323238;12976.156549824325;12197.329146896916;12582.68543286416;12711.300878451682;12841.036922230776;12960.157589756729;10565.894341056644;10648.41433721145;10722.249442539025;10755.3009054412;11042.392668403234;3512.332656795201;3584.62361452049;3585.3904836177912;3648.41625339947;3663.3405986922344;47744.28383574214;49446.50553494455;50102;50336.49663503392;50473.24290135651;9189.540522973824;9205.493697846548;9292.95353523228;9365.344425890122;9390.85913711295;15278.465253716067;15331.770023449433;15332.156731379659;15338.76991845101;15365.308561114776;7625.275598818214;7743.728969486041;7855.450118491651;7858.1356050834365;7933.048034235813;4227.8584782108655;4256.765877876746;4385.451818522684;4434.977825110854;4510.729356238636;2969.3170570768843;2995.6405231371937;3002.4145291667915;3011.021418039146;3012.1264833198566;572.936976932537;588.2264821759372;593.8295529838448;601.7743346245159;603.9879202416015;527.6491133396325;589.5313225985352;607.6566739792004;631.4190944331226;634.105910665968;7833.451658383859;8017.51894886297;8055.558315367003;8200.630971606291;8206.794830129294;571.5113577890927;571.7312862954404;574.1387918122816;592.599995003371;625.5183508698368;3702.66675999156;3719.683826874692;3809.42858571211;3836.9040773980314;3838.27072856162;52733.47266527362;54824.17763733547;54855.45144548583;55123.17315240275;55346.44653553493;43443.565564344586;48050;48974.75512622414;49140.50859491359;52811.73594132005;43135.35296970548;43327;43384.13231735348;43448.78275608602;43940.56059439429;7743.612819358897;7835.608219588884;7990.720324788605;8233.917660823554;8653.39426240157;32586.185345366557;33712.212092130285;34357.141071473416;34499.65500345065;35043.12392190216;43589.12821743484;44330.55669443264;44610.77694611506;45200.54799452095;45206.32190517211;11324.716882078013;11396.829047564128;11404.600838970597;11462.598809041978;11510.39829931772;12137.150399472306;12310.199837010565;12420.565280215149;12655.493780248687;13034.4134513949;11647.941760291144;12045.156839021534;12245.816312755494;12275.26348419062;12304.876951230732;11292.830607541058;11456.140789440991;11758.118141139277;11942.641720748392;12064.819027714415;11433.485493152995;11436.599719009795;11597.13021523406;11782.764344713229;11972.820407693718;9380.906190938003;9452.196563292197;9657.613695452103;9724.416535007922;9978;8661.696840610548;8971.32715046361;8972.416792908702;9274.582643781181;9761.926188119443 06:45:43 INFO - PROCESS | 6158 | __end_tp_report 06:45:43 INFO - PROCESS | 6158 | __start_cc_report 06:45:43 INFO - PROCESS | 6158 | _x_x_mozilla_cycle_collect,699 06:45:43 INFO - PROCESS | 6158 | __end_cc_report 06:45:43 INFO - PROCESS | 6158 | __startTimestamp1456152343183__endTimestamp 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | ------- Summary: start ------- 06:45:43 INFO - PROCESS | 6158 | Number of tests: 6 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#0] dojo.html Cycles:165 Average:5200.09 Median:5398.41 stddev:566.61 (10.5%) stddev-sans-first:544.64 06:45:43 INFO - PROCESS | 6158 | Values: 3132.4 3146.4 3201.6 3204.5 3235.0 4995.8 5082.2 5149.2 5187.5 5215.6 5061.7 5130.8 5222.8 5235.2 5251.9 4650.3 4662.7 4672.1 4677.8 4839.1 4680.9 4768.7 4780.9 4792.4 4837.6 4727.6 4739.8 4753.5 4756.7 4807.8 4800.6 4812.9 4818.1 4818.2 4822.8 4646.0 4791.2 4799.7 4800.6 4859.7 5118.0 5139.6 5139.8 5149.0 5149.5 5656.7 5660.2 5660.4 5668.5 5716.5 5516.4 5657.7 5729.3 5748.0 5791.6 5238.7 5251.3 5252.9 5261.5 5267.2 5622.3 5688.5 5694.3 5703.2 5715.3 5501.2 5532.0 5534.2 5544.8 5577.4 5623.1 5632.7 5636.1 5641.9 5654.5 5440.5 5465.0 5530.0 5569.2 5620.1 5508.1 5511.7 5526.0 5538.9 5551.6 4247.7 4304.1 4322.9 4328.5 4346.4 3876.4 3916.3 3921.0 3929.4 3935.8 5249.5 5288.9 5305.1 5320.4 5352.2 5551.3 5601.0 5673.3 5674.9 5680.7 5201.7 5205.9 5221.0 5225.9 5237.8 4814.1 4815.9 4818.7 4820.1 4844.2 5486.3 5880.1 5893.4 5894.6 5944.9 5561.7 5566.0 5580.6 5587.2 5591.2 5648.9 5779.5 5784.5 5811.0 5820.7 5516.8 5533.9 5551.9 5557.2 5566.6 5608.1 5619.9 5620.1 5624.8 5626.5 5302.8 5429.5 5467.2 5492.1 5518.8 5398.4 5432.3 5439.9 5441.0 5445.8 5251.5 5389.6 5397.7 5402.5 5444.5 5458.3 5478.8 5494.5 5506.3 5544.4 5153.9 5331.8 5345.9 5400.4 5455.1 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#1] ext.html Cycles:180 Average:47789.83 Median:202966.00 stddev:82527.94 (40.7%) stddev-sans-first:82683.16 06:45:43 INFO - PROCESS | 6158 | Values: 528.0 532.0 554.2 556.6 557.9 36850.6 37396.8 37460.3 37478.4 37513.2 37209.0 37266.0 37557.8 37627.4 37786.0 8349.6 8552.0 8568.3 8574.4 8574.5 8415.0 8773.5 8789.3 8791.7 8792.2 8713.3 8758.7 8771.3 8788.7 8799.0 8671.5 8727.1 8732.1 8747.9 8763.8 8633.4 8751.9 8756.3 8756.5 8758.4 36243.0 36711.5 36746.6 36760.3 36818.3 2428.9 3233.3 3305.5 3333.3 3420.5 27331.3 27353.6 27538.4 27601.4 27602.3 3807.9 3831.8 3900.6 3909.1 3921.4 273229.0 276353.0 277572.0 277662.0 368723.0 62829.7 64172.0 64293.0 64307.4 64425.0 56400.7 56553.7 56695.0 56752.7 56791.0 15374.2 15520.6 15539.0 15572.1 15624.1 11537.0 11675.2 11741.6 11812.6 11849.9 20531.4 20756.0 20875.6 20937.2 20962.8 8074.5 8173.3 8177.2 8246.0 8258.8 885.3 916.0 917.6 933.8 1063.9 25585.9 26301.7 26314.3 26393.2 30463.0 968.0 992.6 1030.2 1059.5 1093.0 14302.6 14403.1 14419.7 14601.6 14700.3 363317.0 366029.0 366151.0 366935.0 366975.0 54394.5 54437.7 54462.2 54469.0 54510.7 1277.9 1359.8 1368.4 1374.9 1378.2 30569.0 31049.0 31499.4 32358.5 33038.2 45932.0 46046.8 46516.3 46536.0 46593.0 221086.0 224380.0 294468.0 302856.0 309080.0 38237.2 39142.2 42118.0 43050.0 43547.3 38696.6 39298.6 39554.0 39838.2 40019.8 33643.0 33687.5 34001.1 34088.5 34290.3 33168.7 33544.0 35205.8 37434.3 38454.0 33928.2 34188.0 34247.5 38563.4 39063.6 29550.0 33458.3 34502.3 34513.8 35313.6 25387.5 25460.0 25612.6 25644.4 25942.1 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#2] jquery.html Cycles:180 Average:22349.73 Median:206350.71 stddev:58321.36 (28.3%) stddev-sans-first:58461.58 06:45:43 INFO - PROCESS | 6158 | Values: 352.8 359.6 361.8 363.2 365.6 13847.9 16436.7 16789.5 16994.2 17609.6 15842.4 16158.2 16191.9 16309.6 16425.6 5332.3 5414.8 5460.4 5471.4 5513.3 4010.6 4148.4 4155.1 5271.4 5975.6 6109.8 6128.5 6148.1 6149.4 6150.6 5991.4 6143.2 6149.5 6156.3 6210.0 5363.5 5371.4 5397.6 5401.2 5421.6 19969.4 20667.7 20854.8 20859.9 20872.0 2129.6 2149.5 2251.9 2321.0 2541.4 9440.3 9869.9 12989.9 13180.7 13482.7 1763.3 1788.1 1792.3 1831.7 1835.9 62212.0 63437.0 63454.4 63881.0 64202.7 10478.1 10517.7 10547.6 10558.8 10570.6 13851.7 13940.5 13952.6 13956.4 13995.0 7846.7 7875.4 7887.0 7917.5 7918.2 7507.5 7563.6 7612.5 7631.5 7645.8 4466.0 4556.9 4566.6 4600.6 4617.9 1731.5 1753.6 1769.9 1801.1 1809.2 434.5 436.5 904.6 971.7 987.7 10162.3 10533.9 10806.1 11079.3 11306.7 446.5 478.3 490.0 494.2 512.0 5999.6 6128.0 6254.5 6265.0 6278.2 250428.0 282614.0 349438.0 408553.0 435647.0 65500.7 72968.3 75482.6 75589.0 77424.6 436.8 452.1 452.4 455.6 457.2 10042.0 10496.5 10592.6 10721.6 10820.5 33741.0 33860.5 34382.5 34568.5 34604.0 46220.5 46579.8 46955.5 47514.8 47736.3 7709.4 7832.1 7935.1 8044.4 8183.9 10165.3 10622.5 12024.3 12232.1 12305.1 9973.8 9993.0 10022.8 10026.7 10126.9 10200.7 10293.7 10319.2 10448.2 10504.9 10080.6 10368.5 10410.5 10506.3 10613.4 7733.1 7875.3 7878.7 8050.8 8101.3 10313.8 10319.3 10325.4 10466.5 10556.3 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#3] mootools.html Cycles:180 Average:5530.45 Median:6077.12 stddev:2905.64 (47.8%) stddev-sans-first:2896.48 06:45:43 INFO - PROCESS | 6158 | Values: 1310.9 1474.1 1491.5 1604.7 1735.1 7522.7 7707.3 7717.7 7733.7 7742.7 7566.2 7711.7 7717.3 7748.9 7753.0 1975.6 2029.5 2303.2 2321.1 2330.7 2339.3 2347.4 2349.6 2350.2 2352.0 2232.0 2283.5 2287.2 2289.3 2290.6 2239.7 2281.7 2326.6 2330.8 2338.9 2296.5 2305.9 2325.2 2325.4 2339.0 7884.6 7936.3 7949.8 7952.9 7953.3 4832.8 4920.0 4951.5 4953.3 4956.7 3223.4 3268.1 3332.3 3335.7 3344.2 1107.2 1111.0 1122.2 1134.0 1147.5 10960.9 11046.3 11049.0 11051.5 11060.8 4350.3 4362.6 4421.8 4423.8 4456.2 9385.4 9396.3 9404.8 9419.2 9419.3 4263.9 4856.3 4895.5 4899.8 4904.1 3885.1 4199.1 4260.3 4262.6 4273.9 3694.6 3696.2 3701.8 3738.6 3747.2 1178.3 1182.4 1190.4 1195.7 1203.3 1315.4 1321.9 1340.6 1361.5 1367.5 7419.1 7566.7 7568.8 7617.7 7620.7 507.4 510.5 517.8 519.3 522.5 5705.4 5739.7 5749.3 5775.9 5776.2 9022.1 9714.1 9815.5 9839.3 9850.0 9622.0 9653.2 9662.5 9671.8 9693.9 7216.4 7523.2 7546.1 7548.7 7670.6 7203.7 7212.3 7271.3 7282.5 7283.8 8532.1 8647.4 8702.7 8790.4 8793.9 8736.6 8873.7 8896.8 9072.8 9106.6 5999.3 6154.9 6156.4 7046.3 7114.2 7234.4 7419.9 7444.2 7449.4 7449.7 6614.3 6720.9 6740.1 6810.3 6854.6 6792.4 6827.2 6842.2 6885.4 6950.7 7004.0 7096.8 7130.2 7144.3 7148.5 6570.8 6598.5 6621.1 6624.5 6638.3 6667.0 6709.8 6718.7 6718.8 6720.8 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#4] prototype.html Cycles:180 Average:5208.45 Median:5895.01 stddev:1554.43 (26.4%) stddev-sans-first:1514.92 06:45:43 INFO - PROCESS | 6158 | Values: 322.8 330.9 332.6 333.3 333.9 5684.6 5752.1 5812.9 5816.7 5899.9 5775.9 5806.6 5821.4 5828.6 5859.9 4575.7 4575.8 4577.5 4581.0 4582.0 4339.0 4453.0 4522.8 4543.8 4585.2 4474.9 4481.3 4483.6 4491.6 4518.8 4522.1 4528.2 4531.3 4538.7 4540.1 4015.0 4017.2 4020.2 4025.8 4029.4 5617.0 5622.9 5624.0 5628.7 5630.6 5252.7 5261.4 5265.9 5274.7 5275.2 5907.3 6104.5 6133.1 6140.2 6151.0 4298.0 4298.5 4302.2 4302.7 4303.4 6276.0 6373.2 6455.4 6494.5 6503.1 4392.7 4412.2 4413.6 4414.6 4425.3 4465.2 4465.7 4469.4 4476.6 4477.1 5158.9 5165.8 5167.1 5168.7 5183.0 5957.9 6031.6 6200.6 6210.0 6222.1 1608.8 1620.2 1626.6 1627.7 1633.3 1083.2 1097.9 1099.5 1101.4 1133.0 5897.1 5901.7 5903.7 5904.7 5914.3 6381.9 6387.1 6389.3 6389.5 6393.6 5842.5 5892.9 5897.5 5905.5 5908.1 3406.5 3445.7 3446.9 3449.6 3452.7 6412.0 6667.9 6669.3 6675.5 6749.9 6587.4 6619.6 6622.4 6626.5 6634.9 6697.9 6703.1 6708.6 6718.4 6720.7 6409.7 6416.6 6416.9 6417.5 6422.7 6153.5 6308.7 6322.8 6331.0 6340.1 6674.7 6679.7 6694.5 6698.9 6709.3 4380.6 4417.7 4420.1 4422.0 4422.3 6173.9 6306.7 6420.2 6426.1 6428.1 6259.6 6267.2 6273.4 6284.6 6286.8 6266.5 6267.1 6276.1 6279.8 6280.5 6108.4 6157.2 6163.1 6171.4 6187.9 6125.7 6287.5 6293.0 6299.7 6300.0 6117.2 6121.1 6127.3 6144.3 6165.0 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - PROCESS | 6158 | [#5] yui.html Cycles:180 Average:13522.31 Median:46475.30 stddev:15444.73 (33.2%) stddev-sans-first:15458.03 06:45:43 INFO - PROCESS | 6158 | Values: 697.3 709.7 726.0 821.0 828.0 13811.7 13968.0 14005.7 14029.1 14041.0 13324.5 13385.8 13465.9 14415.1 14472.1 806.3 806.5 811.5 814.4 815.4 794.3 806.2 807.1 809.0 812.4 840.5 851.1 851.9 853.2 853.8 844.0 847.1 847.7 849.6 851.0 625.1 625.5 625.8 627.7 628.5 12862.9 12894.1 12919.9 12931.9 12976.2 12197.3 12582.7 12711.3 12841.0 12960.2 10565.9 10648.4 10722.2 10755.3 11042.4 3512.3 3584.6 3585.4 3648.4 3663.3 47744.3 49446.5 50102.0 50336.5 50473.2 9189.5 9205.5 9293.0 9365.3 9390.9 15278.5 15331.8 15332.2 15338.8 15365.3 7625.3 7743.7 7855.5 7858.1 7933.0 4227.9 4256.8 4385.5 4435.0 4510.7 2969.3 2995.6 3002.4 3011.0 3012.1 572.9 588.2 593.8 601.8 604.0 527.6 589.5 607.7 631.4 634.1 7833.5 8017.5 8055.6 8200.6 8206.8 571.5 571.7 574.1 592.6 625.5 3702.7 3719.7 3809.4 3836.9 3838.3 52733.5 54824.2 54855.5 55123.2 55346.4 43443.6 48050.0 48974.8 49140.5 52811.7 43135.4 43327.0 43384.1 43448.8 43940.6 7743.6 7835.6 7990.7 8233.9 8653.4 32586.2 33712.2 34357.1 34499.7 35043.1 43589.1 44330.6 44610.8 45200.5 45206.3 11324.7 11396.8 11404.6 11462.6 11510.4 12137.2 12310.2 12420.6 12655.5 13034.4 11647.9 12045.2 12245.8 12275.3 12304.9 11292.8 11456.1 11758.1 11942.6 12064.8 11433.5 11436.6 11597.1 11782.8 11972.8 9380.9 9452.2 9657.6 9724.4 9978.0 8661.7 8971.3 8972.4 9274.6 9761.9 06:45:43 INFO - PROCESS | 6158 | -------- Summary: end -------- 06:45:43 INFO - PROCESS | 6158 | 06:45:43 INFO - TEST-INFO | 6158: exit 0 06:45:43 INFO - TEST-OK | dromaeo_css | took 1112823ms 06:45:43 INFO - TEST-START | kraken 06:45:43 INFO - operating with platform_type : linux_ 06:45:43 INFO - Initialising browser for kraken test... 06:45:43 INFO - TEST-INFO | started process 6345 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt7h0CW/profile http://localhost:44083/getInfo.html) 06:45:47 INFO - PROCESS | 6345 | __metrics Screen width/height:1600/1200 06:45:47 INFO - PROCESS | 6345 | colorDepth:24 06:45:47 INFO - PROCESS | 6345 | Browser inner width/height: 1024/697 06:45:47 INFO - PROCESS | 6345 | __metrics 06:45:48 INFO - PROCESS | 6345 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:45:49 INFO - TEST-INFO | 6345: exit 0 06:45:49 INFO - Browser initialized. 06:45:49 INFO - Running cycle 1/1 for kraken test... 06:45:49 INFO - TEST-INFO | started process 6430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt7h0CW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:01 INFO - PROCESS | 6430 | RSS: Main: 147804160 06:46:01 INFO - PROCESS | 6430 | 06:46:03 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44083/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:04 INFO - PROCESS | 6430 | RSS: Main: 192409600 06:46:04 INFO - PROCESS | 6430 | 06:46:07 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44083/tests/kraken/driver.html?testName=audio-dft) 06:46:07 INFO - PROCESS | 6430 | RSS: Main: 181473280 06:46:07 INFO - PROCESS | 6430 | 06:46:10 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44083/tests/kraken/driver.html?testName=audio-fft) 06:46:11 INFO - PROCESS | 6430 | RSS: Main: 166387712 06:46:11 INFO - PROCESS | 6430 | 06:46:13 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44083/tests/kraken/driver.html?testName=audio-oscillator) 06:46:13 INFO - PROCESS | 6430 | RSS: Main: 166494208 06:46:13 INFO - PROCESS | 6430 | 06:46:15 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44083/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:46:16 INFO - PROCESS | 6430 | RSS: Main: 171192320 06:46:16 INFO - PROCESS | 6430 | 06:46:19 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44083/tests/kraken/driver.html?testName=imaging-darkroom) 06:46:20 INFO - PROCESS | 6430 | RSS: Main: 170799104 06:46:20 INFO - PROCESS | 6430 | 06:46:23 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44083/tests/kraken/driver.html?testName=imaging-desaturate) 06:46:24 INFO - PROCESS | 6430 | RSS: Main: 172138496 06:46:24 INFO - PROCESS | 6430 | 06:46:26 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44083/tests/kraken/driver.html?testName=json-parse-financial) 06:46:27 INFO - PROCESS | 6430 | RSS: Main: 169099264 06:46:27 INFO - PROCESS | 6430 | 06:46:28 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44083/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:46:29 INFO - PROCESS | 6430 | RSS: Main: 181878784 06:46:29 INFO - PROCESS | 6430 | 06:46:31 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:46:31 INFO - PROCESS | 6430 | RSS: Main: 180695040 06:46:31 INFO - PROCESS | 6430 | 06:46:33 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:46:34 INFO - PROCESS | 6430 | RSS: Main: 196464640 06:46:34 INFO - PROCESS | 6430 | 06:46:36 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:46:37 INFO - PROCESS | 6430 | RSS: Main: 203206656 06:46:37 INFO - PROCESS | 6430 | 06:46:40 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:46:40 INFO - PROCESS | 6430 | RSS: Main: 199913472 06:46:40 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | Cycle 1(1): loaded http://localhost:44083/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44083/tests/kraken/driver.html?testName=ai-astar) 06:46:42 INFO - PROCESS | 6430 | RSS: Main: 260333568 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | __start_tp_report 06:46:42 INFO - PROCESS | 6430 | _x_x_mozilla_page_load 06:46:42 INFO - PROCESS | 6430 | _x_x_mozilla_page_load_details 06:46:42 INFO - PROCESS | 6430 | |i|pagename|runs| 06:46:42 INFO - PROCESS | 6430 | |0;ai-astar;111;112;109;113;111;112;101;111;112;111 06:46:42 INFO - PROCESS | 6430 | |1;audio-beat-detection;150;127;152;168;128;152;149;129;164;134 06:46:42 INFO - PROCESS | 6430 | |2;audio-dft;161;163;161;161;161;160;160;162;161;163 06:46:42 INFO - PROCESS | 6430 | |3;audio-fft;73;73;107;94;73;73;75;118;95;73 06:46:42 INFO - PROCESS | 6430 | |4;audio-oscillator;97;97;157;95;96;96;150;96;96;137 06:46:42 INFO - PROCESS | 6430 | |5;imaging-gaussian-blur;118;115;115;115;115;116;114;115;115;115 06:46:42 INFO - PROCESS | 6430 | |6;imaging-darkroom;147;146;146;145;147;148;147;147;148;148 06:46:42 INFO - PROCESS | 6430 | |7;imaging-desaturate;97;96;96;96;96;96;96;96;97;96 06:46:42 INFO - PROCESS | 6430 | |8;json-parse-financial;57;59;59;56;58;58;60;66;54;56 06:46:42 INFO - PROCESS | 6430 | |9;json-stringify-tinderbox;68;67;69;67;69;69;68;68;68;67 06:46:42 INFO - PROCESS | 6430 | |10;stanford-crypto-aes;82;81;83;82;83;84;83;85;83;83 06:46:42 INFO - PROCESS | 6430 | |11;stanford-crypto-ccm;126;121;122;123;118;122;113;119;117;115 06:46:42 INFO - PROCESS | 6430 | |12;stanford-crypto-pbkdf2;167;143;152;153;161;141;151;150;152;156 06:46:42 INFO - PROCESS | 6430 | |13;stanford-crypto-sha256-iterative;69;69;70;68;68;70;69;68;70;68 06:46:42 INFO - PROCESS | 6430 | __end_tp_report 06:46:42 INFO - PROCESS | 6430 | __start_cc_report 06:46:42 INFO - PROCESS | 6430 | _x_x_mozilla_cycle_collect,978 06:46:42 INFO - PROCESS | 6430 | __end_cc_report 06:46:42 INFO - PROCESS | 6430 | __startTimestamp1456152402642__endTimestamp 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | ------- Summary: start ------- 06:46:42 INFO - PROCESS | 6430 | Number of tests: 14 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.43 (3.1%) stddev-sans-first:3.63 06:46:42 INFO - PROCESS | 6430 | Values: 111.0 112.0 109.0 113.0 111.0 112.0 101.0 111.0 112.0 111.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:151.00 stddev:14.97 (9.9%) stddev-sans-first:15.79 06:46:42 INFO - PROCESS | 6430 | Values: 150.0 127.0 152.0 168.0 128.0 152.0 149.0 129.0 164.0 134.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 06:46:42 INFO - PROCESS | 6430 | Values: 161.0 163.0 161.0 161.0 161.0 160.0 160.0 162.0 161.0 163.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#3] audio-fft Cycles:10 Average:85.40 Median:73.00 stddev:16.91 (23.2%) stddev-sans-first:17.33 06:46:42 INFO - PROCESS | 6430 | Values: 73.0 73.0 107.0 94.0 73.0 73.0 75.0 118.0 95.0 73.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:96.00 stddev:25.51 (26.6%) stddev-sans-first:26.50 06:46:42 INFO - PROCESS | 6430 | Values: 97.0 97.0 157.0 95.0 96.0 96.0 150.0 96.0 96.0 137.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.06 (0.9%) stddev-sans-first:0.50 06:46:42 INFO - PROCESS | 6430 | Values: 118.0 115.0 115.0 115.0 115.0 116.0 114.0 115.0 115.0 115.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 06:46:42 INFO - PROCESS | 6430 | Values: 147.0 146.0 146.0 145.0 147.0 148.0 147.0 147.0 148.0 148.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:46:42 INFO - PROCESS | 6430 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.50 stddev:3.23 (5.5%) stddev-sans-first:3.40 06:46:42 INFO - PROCESS | 6430 | Values: 57.0 59.0 59.0 56.0 58.0 58.0 60.0 66.0 54.0 56.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:46:42 INFO - PROCESS | 6430 | Values: 68.0 67.0 69.0 67.0 69.0 69.0 68.0 68.0 68.0 67.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.10 (1.3%) stddev-sans-first:1.12 06:46:42 INFO - PROCESS | 6430 | Values: 82.0 81.0 83.0 82.0 83.0 84.0 83.0 85.0 83.0 83.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:121.50 stddev:3.95 (3.3%) stddev-sans-first:3.44 06:46:42 INFO - PROCESS | 6430 | Values: 126.0 121.0 122.0 123.0 118.0 122.0 113.0 119.0 117.0 115.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.50 stddev:7.65 (5.0%) stddev-sans-first:6.08 06:46:42 INFO - PROCESS | 6430 | Values: 167.0 143.0 152.0 153.0 161.0 141.0 151.0 150.0 152.0 156.0 06:46:42 INFO - PROCESS | 6430 | 06:46:42 INFO - PROCESS | 6430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 06:46:42 INFO - PROCESS | 6430 | Values: 69.0 69.0 70.0 68.0 68.0 70.0 69.0 68.0 70.0 68.0 06:46:42 INFO - PROCESS | 6430 | -------- Summary: end -------- 06:46:42 INFO - PROCESS | 6430 | 06:46:43 INFO - TEST-INFO | 6430: exit 0 06:46:43 INFO - TEST-OK | kraken | took 59783ms 06:46:43 INFO - SUITE-END | took 1172s 06:46:43 INFO - Completed test suite (00:19:32) 06:46:43 INFO - Working with test: dromaeo_css 06:46:43 INFO - Generating results file: dromaeo_css 06:46:43 INFO - Working with test: kraken 06:46:43 INFO - Generating results file: kraken 06:46:43 INFO - javascript benchmark 06:46:43 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:46:43 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:46:43 INFO - process_Request line: dromaeo_css 6769.87 graph.html#tests=[[72,1,35]] 06:46:43 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:46:43 INFO - process_Request line: kraken 1522.70 graph.html#tests=[[232,1,35]] 06:46:43 INFO - RETURN: dromaeo_css: 6769.87 06:46:43 INFO - RETURN: kraken: 1522.70 06:46:43 INFO - javascript benchmark 06:46:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3132.3578666373396, 3146.402183585117, 3201.599800024997, 3204.503301988191, 3234.9676503234973, 4995.75021248937, 5082.186850103984, 5149.1503901856195, 5187.507186817251, 5215.608829337796, 5061.6709913855575, 5130.846074617758, 5222.817201397952, 5235.1885457754015, 5251.947480525194, 4650.302454631816, 4662.650301227413, 4672.0889426561835, 4677.766111694402, 4839.05638400512, 4680.882977925562, 4768.73771942543, 4780.856574302777, 4792.424909010923, 4837.588804951583, 4727.598154156901, 4739.786709598076, 4753.548412900769, 4756.7145971241835, 4807.783649735753, 4800.639952003578, 4812.879678008043, 4818.060478206716, 4818.204996175627, 4822.758862056883, 4645.976770116128, 4791.233402655594, 4799.688020278671, 4800.615950723969, 4859.659823812334, 5117.974410127963, 5139.640225184238, 5139.794408223666, 5148.974255128738, 5149.485051494858, 5656.688882111483, 5660.150977353389, 5660.377358490604, 5668.461496157858, 5716.542676585905, 5516.393196748354, 5657.660540367591, 5729.341125770548, 5747.971260143672, 5791.594588378815, 5238.685678859242, 5251.264822924793, 5252.868678283074, 5261.5264626183825, 5267.209918512215, 5622.297212848394, 5688.488036076773, 5694.259746232963, 5703.230063941398, 5715.257016587817, 5501.229827824108, 5532.0, 5534.1975413565615, 5544.750486228129, 5577.358603760619, 5623.100303951348, 5632.662040277596, 5636.126400407861, 5641.8589535261945, 5654.491095801398, 5440.455954404607, 5465.0, 5529.976954263474, 5569.164625306155, 5620.100783874561, 5508.118701007819, 5511.669299842022, 5526.0, 5538.9169162462595, 5551.611387202938, 4247.723897946686, 4304.139172165516, 4322.8703138905885, 4328.523862375137, 4346.413234213404, 3876.4185372194397, 3916.2950668879876, 3921.0, 3929.390944403622, 3935.803209839554, 5249.501297376743, 5288.867778305573, 5305.076874678582, 5320.388155362183, 5352.170413585901, 5551.333839939233, 5601.0, 5673.31920169574, 5674.858128546819, 5680.687562184037, 5201.713905735221, 5205.895882082337, 5221.008008478377, 5225.921611175835, 5237.764300606482, 4814.109389762905, 4815.879603009883, 4818.6626936114135, 4820.084184005028, 4844.249141383091, 5486.341639003345, 5880.059190529495, 5893.381194974551, 5894.587378883437, 5944.910826337608, 5561.721913904208, 5565.972170139124, 5580.5535557156145, 5587.161925711013, 5591.217229587943, 5648.85877853057, 5779.479846813807, 5784.5083167929515, 5811.0, 5820.650760954356, 5516.779328826802, 5533.889322213614, 5551.944480555304, 5557.221988921473, 5566.638168519034, 5608.130739735348, 5619.943800561942, 5620.072688006433, 5624.803131890528, 5626.465485778845, 5302.814401495929, 5429.457054294539, 5467.234587157881, 5492.121260598445, 5518.751656175402, 5398.406175320633, 5432.266644003009, 5439.891202176013, 5441.0, 5445.754941027584, 5251.52736253739, 5389.649672771257, 5397.70312632809, 5402.459754024566, 5444.455554444524, 5458.344998600193, 5478.808241711521, 5494.478024587658, 5506.256655351476, 5544.390117087198, 5153.896922061613, 5331.813386531453, 5345.866353341197, 5400.378956419905, 5455.1271796512365], "unit": "score", "name": "dojo.html", "value": 5164.452185591015}, {"lowerIsBetter": false, "replicates": [528.0310629993961, 531.968081915085, 554.2379228560726, 556.5964675610181, 557.9246801681771, 36850.631493685054, 37396.81301593488, 37460.25397460253, 37478.437823432636, 37513.24973500528, 37209.0, 37266.0, 37557.81221093891, 37627.43558846619, 37786.0, 8349.62426690799, 8552.016518100436, 8568.314534837198, 8574.44266122703, 8574.528400937947, 8415.0, 8773.473591584525, 8789.252913502329, 8791.692290769824, 8792.164744349277, 8713.346499012569, 8758.693445729368, 8771.342149338794, 8788.69239576615, 8799.032106468283, 8671.523066231355, 8727.127287271285, 8732.12678732128, 8747.868781968276, 8763.824723505559, 8633.352498562634, 8751.868721969175, 8756.255718263956, 8756.474611523328, 8758.386912916098, 36243.0, 36711.53153873842, 36746.632533674856, 36760.26479470422, 36818.263634727155, 2428.9434096168225, 3233.2563510392506, 3305.5041743738393, 3333.3000069985333, 3420.521127042216, 27331.316717082034, 27353.589696154573, 27538.449231015467, 27601.447971040667, 27602.309942251402, 3807.866724664651, 3831.7892515911612, 3900.609191818705, 3909.061825161969, 3921.392184211452, 273229.0, 276353.0, 277572.0, 277662.0, 368723.0, 62829.68585157045, 64172.0, 64293.0, 64307.35692643013, 64425.0, 56400.71799640975, 56553.71723141358, 56695.0, 56752.71623641856, 56791.0, 15374.154421506924, 15520.611984700472, 15539.0, 15572.143532105843, 15624.062556246661, 11537.0, 11675.182737208484, 11741.589044383405, 11812.586559470377, 11849.881501184878, 20531.38405847827, 20756.0, 20875.58248835045, 20937.162513499596, 20962.790372096082, 8074.475159114639, 8173.305269052078, 8177.177147292722, 8246.0, 8258.793530161794, 885.2608072259607, 915.9633614655472, 917.6375331744057, 933.7992331648728, 1063.9148868090533, 25585.8720706399, 26301.73698262993, 26314.342141446617, 26393.20820375392, 30463.0, 967.9806403872024, 992.5533509920565, 1030.21703505335, 1059.4637775225954, 1092.9726057505918, 14302.57092287233, 14403.135811851322, 14419.711605767827, 14601.561953141423, 14700.264986750619, 363317.0, 366029.0, 366151.0, 366935.0, 366975.0, 54394.45605543973, 54437.72781136148, 54462.18306725402, 54469.0, 54510.727446362514, 1277.923324600527, 1359.7620416427085, 1368.3500337339683, 1374.8900087992936, 1378.2488543743684, 30569.0, 31049.0, 31499.37001259916, 32358.514622280214, 33038.17404564905, 45932.0, 46046.76976615095, 46516.30225546552, 46536.0, 46593.0, 221086.0, 224380.0, 294468.0, 302856.0, 309080.0, 38237.235255295294, 39142.23859926367, 42118.0, 43050.0, 43547.34678979881, 38696.613033869304, 39298.63679120893, 39554.0, 39838.203235935696, 40019.79990100031, 33643.0, 33687.494687579216, 34001.14997125092, 34088.48867267043, 34290.314193716484, 33168.66831331656, 33544.0, 35205.82397087998, 37434.25131497409, 38454.0, 33928.15179620431, 34188.0, 34247.486287706204, 38563.421548677354, 39063.609363906, 29550.0, 33458.33083338368, 34502.30995380128, 34513.75660582054, 35313.64686353104, 25387.492250155265, 25460.0, 25612.615810763225, 25644.358891027874, 25942.092026778973], "unit": "score", "name": "ext.html", "value": 18456.001474360386}, {"lowerIsBetter": false, "replicates": [352.8412214503474, 359.6331741623544, 361.8317482370697, 363.1792149741584, 365.6161030917536, 13847.930760346184, 16436.67126657466, 16789.49631511055, 16994.235259413326, 17609.64780704385, 15842.445514406998, 16158.192090395492, 16191.919040404811, 16309.59226019347, 16425.58936026597, 5332.33345831771, 5414.83755487336, 5460.399356070829, 5471.398146203935, 5513.255710479094, 4010.6390424861756, 4148.419221309019, 4155.127423241123, 5271.42014378418, 5975.641461512301, 6109.755609775626, 6128.540359473035, 6148.108524263979, 6149.385061493837, 6150.569460137792, 5991.430814072656, 6143.232095988002, 6149.5080393568405, 6156.322804491502, 6209.968950155243, 5363.463653634644, 5371.355437347544, 5397.568194544467, 5401.162819762943, 5421.566274698054, 19969.400917972485, 20667.689984650242, 20854.791452085436, 20859.895700521552, 20872.0, 2129.595376878388, 2149.50561370884, 2251.8761468119246, 2321.048370168223, 2541.3519552514176, 9440.2919781016, 9869.85195222065, 12989.935050324782, 13180.736385272337, 13482.730345393134, 1763.2770564068671, 1788.1148831328446, 1792.2920446423589, 1831.716084006981, 1835.9082045897785, 62212.0, 63437.0, 63454.385473743445, 63881.0, 64202.67898660477, 10478.109360704426, 10517.737056573647, 10547.630832920811, 10558.788824223626, 10570.630027948984, 13851.684090011433, 13940.512082077079, 13952.58142255734, 13956.371963261678, 13995.0, 7846.725364612325, 7875.369970402354, 7886.960565197137, 7917.485363451472, 7918.2477664621765, 7507.549547027086, 7563.584002879785, 7612.505187162817, 7631.503952243086, 7645.808854778675, 4466.0, 4556.88607784808, 4566.634669226454, 4600.631949444037, 4617.884552886205, 1731.5195507840867, 1753.6405036967392, 1769.9026553539422, 1801.1174524482908, 1809.2129923483326, 434.5372178629749, 436.47622852577035, 904.5658084119527, 971.6890595009529, 987.6641941739842, 10162.339447935861, 10533.894661053291, 10806.135509159249, 11079.335239885633, 11306.717332066764, 446.48877035793834, 478.3327258474409, 489.9853004409873, 494.16486138425944, 512.0348143748986, 5999.610025348338, 6128.0, 6254.530910181755, 6264.968675156595, 6278.183836101278, 250428.0, 282614.0, 349438.0, 408553.0, 435647.0, 65500.672496638166, 72968.27031729615, 75482.62258688781, 75589.0, 77424.61287693639, 436.8274531560016, 452.12965042293456, 452.4073463762416, 455.59224494077614, 457.2250036188695, 10042.0, 10496.52765625564, 10592.576296948344, 10721.641238927423, 10820.458977051274, 33741.0, 33860.49209261814, 34382.484262735576, 34568.48147277743, 34604.0, 46220.537794621625, 46579.767101164274, 46955.53044469511, 47514.76242618903, 47736.28395574, 7709.383249340151, 7832.138464768757, 7935.1271360149185, 8044.436889417919, 8183.8772418414965, 10165.288429809842, 10622.468876555986, 12024.33866137371, 12232.143749937419, 12305.077119215915, 9973.800523989334, 9993.0, 10022.799544008933, 10026.749331266485, 10126.949365253127, 10200.693979180636, 10293.691189264335, 10319.174466042849, 10448.2163837714, 10504.947475262881, 10080.647177348757, 10368.533415996148, 10410.47947602632, 10506.264561480622, 10613.363198208132, 7733.110692270461, 7875.251851074138, 7878.724244651639, 8050.758477245692, 8101.311388532041, 10313.845292320471, 10319.329243599143, 10325.432101234504, 10466.476676166314, 10556.313839600401], "unit": "score", "name": "jquery.html", "value": 7708.537939627935}, {"lowerIsBetter": false, "replicates": [1310.88857447117, 1474.0713350589128, 1491.5152575412988, 1604.7352186889163, 1735.1150913034348, 7522.699092036319, 7707.267809558097, 7717.652705628247, 7733.7293194738195, 7742.651580678869, 7566.167721550625, 7711.730089446871, 7717.266859648338, 7748.883766743489, 7752.961235193816, 1975.6147551227516, 2029.5027718208985, 2303.2284184798114, 2321.1411777642297, 2330.7436182019965, 2339.344983404641, 2347.366211122996, 2349.600567903452, 2350.165691179632, 2352.0356653771955, 2231.966520502194, 2283.4976305212826, 2287.1994801819396, 2289.2559918026623, 2290.5533420982915, 2239.708837851077, 2281.6577513372963, 2326.6161083421216, 2330.790228879392, 2338.9181378651665, 2296.494771150344, 2305.8501197422115, 2325.197806756666, 2325.383773300077, 2339.02930283932, 7884.64519096642, 7936.285734283884, 7949.801254968615, 7952.880706789403, 7953.284204421572, 4832.806687732486, 4919.950800491985, 4951.529604687549, 4953.306537084811, 4956.677815941988, 3223.4358987177384, 3268.0686004488844, 3332.266901281714, 3335.7331413486863, 3344.2308269098, 1107.213878146517, 1110.9777804443947, 1122.1639878290725, 1134.0417347341483, 1147.4549588945267, 10960.890391096067, 11046.33721976676, 11049.0, 11051.502682379232, 11060.778784424347, 4350.347447882779, 4362.563743625612, 4421.756803375845, 4423.778811059498, 4456.24243878535, 9385.436873787594, 9396.295277854188, 9404.764880878032, 9419.24646028316, 9419.340646154704, 4263.914721705549, 4856.344393506832, 4895.510448955076, 4899.755012249373, 4904.141775189328, 3885.1258466844733, 4199.076203235283, 4260.275753121977, 4262.616364527207, 4273.9358909616385, 3694.649008344203, 3696.242270334575, 3701.777893326409, 3738.551373835103, 3747.1568896997956, 1178.3401295274673, 1182.3851597169423, 1190.36315571169, 1195.6771671648605, 1203.2599951030054, 1315.3620494060374, 1321.9074664773566, 1340.6112227454123, 1361.5302720561588, 1367.466687991684, 7419.07261592301, 7566.659500322388, 7568.848623027508, 7617.6572054257695, 7620.657070431844, 507.3632591098148, 510.5481648740817, 517.7877070401117, 519.3300642171632, 522.5206395652652, 5705.429457054262, 5739.713014349266, 5749.310082790092, 5775.855603609859, 5776.191333213354, 9022.14289642483, 9714.125728684452, 9815.509224538744, 9839.311248212556, 9850.0, 9622.0, 9653.22774178064, 9662.516874156265, 9671.758206044764, 9693.854592181124, 7216.422686185093, 7523.210062943313, 7546.132194797558, 7548.698052077855, 7670.616469176519, 7203.71185152588, 7212.3148300911325, 7271.345578897713, 7282.526635768658, 7283.781486555412, 8532.104129066358, 8647.437916535406, 8702.738917832476, 8790.42862213954, 8793.868091978498, 8736.563171841255, 8873.73378798637, 8896.777580560538, 9072.818543629222, 9106.590203440728, 5999.310079340931, 6154.9384506154365, 6156.384361563987, 7046.26014268515, 7114.181869085121, 7234.385077268491, 7419.9258007421395, 7444.218357072646, 7449.366803821736, 7449.7020119196795, 6614.272430032789, 6720.899186512109, 6740.056392105012, 6810.31896810315, 6854.554453960476, 6792.388685018372, 6827.21487028998, 6842.24735279109, 6885.449164066963, 6950.721971121098, 7004.0, 7096.787096387116, 7130.18002929649, 7144.3212894774915, 7148.535345202546, 6570.77002304917, 6598.472122230114, 6621.1392518972225, 6624.536282460182, 6638.269790323157, 6666.966665166643, 6709.7651582194385, 6718.697658605277, 6718.764843230463, 6720.764773232913], "unit": "score", "name": "mootools.html", "value": 4477.3663077640995}, {"lowerIsBetter": false, "replicates": [322.78534774375044, 330.85607760624123, 332.5909131767924, 333.3017328696381, 333.9031282237848, 5684.630499017561, 5752.137179423078, 5812.854678633036, 5816.651000939942, 5899.911501327478, 5775.884482310351, 5806.564507661932, 5821.3887541808135, 5828.562857785672, 5859.941400585993, 4575.656825738083, 4575.771211439414, 4577.496475387705, 4580.954190458103, 4582.03777206787, 4338.97830510847, 4453.042595841894, 4522.773861306938, 4543.795529201194, 4585.220512512864, 4474.932876006863, 4481.305397663367, 4483.5516448355065, 4491.6182124519455, 4518.819247230107, 4522.050369422442, 4528.18492671319, 4531.252343363341, 4538.682292239545, 4540.091981603659, 4015.0, 4017.1563971566006, 4020.2361551305157, 4025.798710064514, 4029.37544680575, 5617.0, 5622.91565626516, 5623.971880140614, 5628.746706398222, 5630.634008789416, 5252.715068945021, 5261.447548007481, 5265.947340526623, 5274.705503106123, 5275.208718692188, 5907.291125064977, 6104.481119104837, 6133.1413602095745, 6140.171076904606, 6150.96924515379, 4298.032942587924, 4298.527162012176, 4302.204092242914, 4302.698811083225, 4303.397524346594, 6275.96862015687, 6373.235211774617, 6455.386738259858, 6494.512911531607, 6503.089567460606, 4392.714473559208, 4412.161689279027, 4413.624841888475, 4414.602685758297, 4425.336199570026, 4465.1962646723905, 4465.709728867613, 4469.41897553316, 4476.574725401082, 4477.1269602427865, 5158.92261616076, 5165.767540460688, 5167.0957582422925, 5168.689878607295, 5183.015227106837, 5957.851053723692, 6031.577789554777, 6200.627962322184, 6209.96895015531, 6222.066689996446, 1608.806943166804, 1620.173711407191, 1626.6421387294777, 1627.6744651069832, 1633.2650307361735, 1083.1767856429012, 1097.9341239525654, 1099.5491848342142, 1101.3832253937821, 1132.994335028336, 5897.144913987534, 5901.701625642352, 5903.734331954986, 5904.704764761831, 5914.290285165807, 6381.8723625528155, 6387.137736405526, 6389.274895778114, 6389.456896163785, 6393.648349340738, 5842.474177324061, 5892.882142357129, 5897.469227769436, 5905.4685078343155, 5908.084246941731, 3406.454967205285, 3445.707114895212, 3446.8965931022108, 3449.6032956209856, 3452.7065199457825, 6411.967940160363, 6667.86664266712, 6669.266380698119, 6675.499337549703, 6749.8650026999185, 6587.374199451045, 6619.635920024445, 6622.437092847162, 6626.503012274099, 6634.900476492857, 6697.866042679217, 6703.12859328294, 6708.597484150967, 6718.395344419026, 6720.731170753213, 6409.743610255724, 6416.550841441054, 6416.871662566816, 6417.48660107181, 6422.743090276336, 6153.507719382528, 6308.684565771785, 6322.841928951813, 6330.987042073246, 6340.1123842661145, 6674.733010679518, 6679.732810687518, 6694.4644428444635, 6698.866022679422, 6709.329067093252, 4380.5838445347645, 4417.690761646782, 4420.071784925201, 4422.049259409242, 4422.270325396274, 6173.876522469435, 6306.65313407767, 6420.165378500765, 6426.132472116205, 6428.132202152649, 6259.593126446766, 6267.2479302484, 6273.435390814849, 6284.5600807943, 6286.842828929313, 6266.467350275096, 6267.122602835698, 6276.089966954674, 6279.780207692709, 6280.466160376419, 6108.419700128481, 6157.230346206724, 6163.106349579376, 6171.382861713792, 6187.907181392373, 6125.724342404514, 6287.46556542699, 6292.968535157295, 6299.653519056313, 6299.992001279773, 6117.174181485442, 6121.051237058263, 6127.3259941407305, 6144.262688477412, 6165.013597824506], "unit": "score", "name": "prototype.html", "value": 4707.464424479606}, {"lowerIsBetter": false, "replicates": [697.2539382860339, 709.6912842913337, 725.9854802903942, 820.9712660056899, 827.9710210142646, 13811.654708632277, 13968.0, 14005.719885602282, 14029.088109272903, 14041.0, 13324.533641322556, 13385.79921301179, 13465.932670336659, 14415.063020903634, 14472.131672099682, 806.2542148512632, 806.4637016384127, 811.5212024905304, 814.360726829439, 815.4332738746574, 794.2732399854126, 806.1857523900844, 807.1283014344494, 809.017044291186, 812.3704129299781, 840.487302745328, 851.1403482482706, 851.9105493923141, 853.1809462915609, 853.7780177153923, 844.0462277626274, 847.1147650704967, 847.7329641163014, 849.6049337058236, 850.961706723199, 625.0592857749104, 625.5183508698323, 625.8216408323606, 627.7175271127965, 628.475223188638, 12862.906652934511, 12894.097413181082, 12919.870801292054, 12931.935340323238, 12976.156549824325, 12197.329146896916, 12582.68543286416, 12711.300878451682, 12841.036922230776, 12960.157589756729, 10565.894341056644, 10648.41433721145, 10722.249442539025, 10755.3009054412, 11042.392668403234, 3512.332656795201, 3584.62361452049, 3585.3904836177912, 3648.41625339947, 3663.3405986922344, 47744.28383574214, 49446.50553494455, 50102.0, 50336.49663503392, 50473.24290135651, 9189.540522973824, 9205.493697846548, 9292.95353523228, 9365.344425890122, 9390.85913711295, 15278.465253716067, 15331.770023449433, 15332.156731379659, 15338.76991845101, 15365.308561114776, 7625.275598818214, 7743.728969486041, 7855.450118491651, 7858.1356050834365, 7933.048034235813, 4227.8584782108655, 4256.765877876746, 4385.451818522684, 4434.977825110854, 4510.729356238636, 2969.3170570768843, 2995.6405231371937, 3002.4145291667915, 3011.021418039146, 3012.1264833198566, 572.936976932537, 588.2264821759372, 593.8295529838448, 601.7743346245159, 603.9879202416015, 527.6491133396325, 589.5313225985352, 607.6566739792004, 631.4190944331226, 634.105910665968, 7833.451658383859, 8017.51894886297, 8055.558315367003, 8200.630971606291, 8206.794830129294, 571.5113577890927, 571.7312862954404, 574.1387918122816, 592.599995003371, 625.5183508698368, 3702.66675999156, 3719.683826874692, 3809.42858571211, 3836.9040773980314, 3838.27072856162, 52733.47266527362, 54824.17763733547, 54855.45144548583, 55123.17315240275, 55346.44653553493, 43443.565564344586, 48050.0, 48974.75512622414, 49140.50859491359, 52811.73594132005, 43135.35296970548, 43327.0, 43384.13231735348, 43448.78275608602, 43940.56059439429, 7743.612819358897, 7835.608219588884, 7990.720324788605, 8233.917660823554, 8653.39426240157, 32586.185345366557, 33712.212092130285, 34357.141071473416, 34499.65500345065, 35043.12392190216, 43589.12821743484, 44330.55669443264, 44610.77694611506, 45200.54799452095, 45206.32190517211, 11324.716882078013, 11396.829047564128, 11404.600838970597, 11462.598809041978, 11510.39829931772, 12137.150399472306, 12310.199837010565, 12420.565280215149, 12655.493780248687, 13034.4134513949, 11647.941760291144, 12045.156839021534, 12245.816312755494, 12275.26348419062, 12304.876951230732, 11292.830607541058, 11456.140789440991, 11758.118141139277, 11942.641720748392, 12064.819027714415, 11433.485493152995, 11436.599719009795, 11597.13021523406, 11782.764344713229, 11972.820407693718, 9380.906190938003, 9452.196563292197, 9657.613695452103, 9724.416535007922, 9978.0, 8661.696840610548, 8971.32715046361, 8972.416792908702, 9274.582643781181, 9761.926188119443], "unit": "score", "name": "yui.html", "value": 6215.839322192866}], "name": "dromaeo_css", "value": 6769.868804784018}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 109.0, 113.0, 111.0, 112.0, 101.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 152.0, 168.0, 128.0, 152.0, 149.0, 129.0, 164.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 145.3}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 107.0, 94.0, 73.0, 73.0, 75.0, 118.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 157.0, 95.0, 96.0, 96.0, 150.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 111.7}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 116.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 148.0, 147.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 59.0, 56.0, 58.0, 58.0, 60.0, 66.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 67.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 82.0, 83.0, 84.0, 83.0, 85.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [126.0, 121.0, 122.0, 123.0, 118.0, 122.0, 113.0, 119.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [167.0, 143.0, 152.0, 153.0, 161.0, 141.0, 151.0, 150.0, 152.0, 156.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 68.0, 68.0, 70.0, 69.0, 68.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1522.7}]} 06:46:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6769.87"}}} 06:46:43 INFO - Return code: 0 06:46:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:46:44 INFO - # TBPL SUCCESS # 06:46:44 INFO - Running post-action listener: _resource_record_post_action 06:46:44 INFO - Running post-run listener: _resource_record_post_run 06:46:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 12288; Write bytes: 546533376; Read time: 308; Write time: 463036 06:46:45 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 251260928; Read time: 120; Write time: 278028 06:46:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295272448; Read time: 188; Write time: 185008 06:46:45 INFO - Running post-run listener: _upload_blobber_files 06:46:45 INFO - Blob upload gear active. 06:46:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:46:45 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:46:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:46:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:46:45 INFO - (blobuploader) - INFO - Open directory for files ... 06:46:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:46:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:46 INFO - (blobuploader) - INFO - Done attempting. 06:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:46:47 INFO - (blobuploader) - INFO - Done attempting. 06:46:47 INFO - (blobuploader) - INFO - Iteration through files over. 06:46:47 INFO - Return code: 0 06:46:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:46:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:46:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995b2dacd97708f1f664861c7f8cbb1e83af7a18c00d41006165d016fbb955b07b496fba52b79c3af9a1fba6bfdd584c62e901a847d8cf03991807de00ff2914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45aaf23a367b8a2a23f406d67c83ba8d813e31cc3f95a3514fd05aadfb668a2ffbd98e1474725adf255a1b43312d0892be920ea7398fe619d5df20c5e57c64e5"} 06:46:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:46:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:46:47 INFO - Contents: 06:46:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995b2dacd97708f1f664861c7f8cbb1e83af7a18c00d41006165d016fbb955b07b496fba52b79c3af9a1fba6bfdd584c62e901a847d8cf03991807de00ff2914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45aaf23a367b8a2a23f406d67c83ba8d813e31cc3f95a3514fd05aadfb668a2ffbd98e1474725adf255a1b43312d0892be920ea7398fe619d5df20c5e57c64e5"} 06:46:47 INFO - Running post-run listener: copy_logs_to_upload_dir 06:46:47 INFO - Copying logs to upload dir... 06:46:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:46:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.463057 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-02-22 06:46:47.254236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:47.261622) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995b2dacd97708f1f664861c7f8cbb1e83af7a18c00d41006165d016fbb955b07b496fba52b79c3af9a1fba6bfdd584c62e901a847d8cf03991807de00ff2914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45aaf23a367b8a2a23f406d67c83ba8d813e31cc3f95a3514fd05aadfb668a2ffbd98e1474725adf255a1b43312d0892be920ea7398fe619d5df20c5e57c64e5"} build_url:https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/Xp7WsxwFQYqy0pv99ADCDw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995b2dacd97708f1f664861c7f8cbb1e83af7a18c00d41006165d016fbb955b07b496fba52b79c3af9a1fba6bfdd584c62e901a847d8cf03991807de00ff2914", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45aaf23a367b8a2a23f406d67c83ba8d813e31cc3f95a3514fd05aadfb668a2ffbd98e1474725adf255a1b43312d0892be920ea7398fe619d5df20c5e57c64e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:47.285848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:47.286165) ========= 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=6dbc10da6d83fee962c624be000001a8-1456150533.11681-1135378825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004757 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:46:47.338790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:46:47.339097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:46:47.342417) ========= ========= Total master_lag: 0.48 =========