builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1450364018.41 results: success (0) buildid: 20151217043003 builduid: 9c1cd80b90da4ef69dbbc4e2d742570f revision: f143af51f6e35932927b8ccac2509facbbe7b539 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.406152) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.406686) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.407019) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006318 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.432083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.432388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.452374) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.452788) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004650 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.518303) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.518605) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.519001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.519308) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 06:53:39-- 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% 219M=0s 2015-12-17 06:53:39 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195875 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.749625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.749917) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016895 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.801440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:38.801867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f143af51f6e35932927b8ccac2509facbbe7b539 --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 f143af51f6e35932927b8ccac2509facbbe7b539 --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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 06:53:39,519 truncating revision to first 12 chars 2015-12-17 06:53:39,519 Setting DEBUG logging. 2015-12-17 06:53:39,519 attempt 1/10 2015-12-17 06:53:39,519 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f143af51f6e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 06:53:39,769 unpacking tar archive at: mozilla-central-f143af51f6e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536431 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:39.351628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:39.351931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:39.362458) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:39.362847) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 06:53:39.363294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 06:53:39.363579) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --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', '--system-bits', '64', '--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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:53:40 INFO - MultiFileLogger online at 20151217 06:53:40 in /builds/slave/test-pgo 06:53:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:53:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:53:40 INFO - {'append_to_log': False, 06:53:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:53:40 INFO - 'blob_upload_branch': 'Firefox', 06:53:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:53:40 INFO - 'branch': 'Firefox', 06:53:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:40 INFO - 'config_files': ('talos/linux_config.py',), 06:53:40 INFO - 'default_actions': ('clobber', 06:53:40 INFO - 'read-buildbot-config', 06:53:40 INFO - 'download-and-extract', 06:53:40 INFO - 'populate-webroot', 06:53:40 INFO - 'create-virtualenv', 06:53:40 INFO - 'install', 06:53:40 INFO - 'run-tests'), 06:53:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:40 INFO - 'download_minidump_stackwalk': True, 06:53:40 INFO - 'download_symbols': 'ondemand', 06:53:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:40 INFO - 'installer_path': 'installer.exe', 06:53:40 INFO - 'log_level': 'info', 06:53:40 INFO - 'log_name': 'talos', 06:53:40 INFO - 'log_to_console': True, 06:53:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:53:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:53:40 INFO - 'opt_config_files': (), 06:53:40 INFO - 'pip_index': False, 06:53:40 INFO - 'sps_profile': False, 06:53:40 INFO - 'sps_profile_interval': 0, 06:53:40 INFO - 'suite': 'dromaeojs', 06:53:40 INFO - 'system_bits': '64', 06:53:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:40 INFO - 'title': 'talos-linux64-ix-042', 06:53:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:40 INFO - 'use_talos_json': True, 06:53:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:53:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:40 INFO - 'work_dir': 'build'} 06:53:40 INFO - ##### 06:53:40 INFO - ##### Running clobber step. 06:53:40 INFO - ##### 06:53:40 INFO - Running pre-action listener: _resource_record_pre_action 06:53:40 INFO - Running main action method: clobber 06:53:40 INFO - rmtree: /builds/slave/test-pgo/build 06:53:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:53:41 INFO - Running post-action listener: _resource_record_post_action 06:53:41 INFO - ##### 06:53:41 INFO - ##### Running read-buildbot-config step. 06:53:41 INFO - ##### 06:53:41 INFO - Running pre-action listener: _resource_record_pre_action 06:53:41 INFO - Running main action method: read_buildbot_config 06:53:41 INFO - Using buildbot properties: 06:53:41 INFO - { 06:53:41 INFO - "project": "", 06:53:41 INFO - "product": "firefox", 06:53:41 INFO - "script_repo_revision": "production", 06:53:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:53:41 INFO - "repository": "", 06:53:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:53:41 INFO - "buildid": "20151217043003", 06:53:41 INFO - "pgo_build": "True", 06:53:41 INFO - "basedir": "/builds/slave/test-pgo", 06:53:41 INFO - "buildnumber": 604, 06:53:41 INFO - "slavename": "talos-linux64-ix-042", 06:53:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:53:41 INFO - "platform": "ubuntu64_hw", 06:53:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:53:41 INFO - "branch": "mozilla-central", 06:53:41 INFO - "repo_path": "mozilla-central", 06:53:41 INFO - "revision": "f143af51f6e35932927b8ccac2509facbbe7b539", 06:53:41 INFO - "stage_platform": "linux64-pgo", 06:53:41 INFO - "builduid": "9c1cd80b90da4ef69dbbc4e2d742570f", 06:53:41 INFO - "slavebuilddir": "test" 06:53:41 INFO - } 06:53:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:53:41 INFO - Running post-action listener: _resource_record_post_action 06:53:41 INFO - ##### 06:53:41 INFO - ##### Running download-and-extract step. 06:53:41 INFO - ##### 06:53:41 INFO - Running pre-action listener: _resource_record_pre_action 06:53:41 INFO - Running main action method: download_and_extract 06:53:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:53:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:41 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json 06:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json 06:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:53:46 INFO - Downloaded 1302 bytes. 06:53:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:53:46 INFO - Using the following test package requirements: 06:53:46 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:46 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:53:46 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'jsshell-linux-x86_64.zip'], 06:53:46 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:53:46 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:46 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:53:46 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:53:46 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:53:46 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:53:46 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:53:46 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:53:46 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:53:46 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:53:46 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:53:48 INFO - Downloaded 23117861 bytes. 06:53:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:53:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:53:49 INFO - Return code: 0 06:53:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:49 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:53:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:53:52 INFO - Downloaded 23117861 bytes. 06:53:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 06:53:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:53:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:53:53 INFO - Return code: 0 06:53:53 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:53:53 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:53:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:53:54 INFO - Downloaded 11132052 bytes. 06:53:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 06:53:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:53:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 06:53:54 INFO - Return code: 0 06:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:54 INFO - https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:53:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:53:56 INFO - Downloaded 59290131 bytes. 06:53:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:56 INFO - mkdir: /builds/slave/test-pgo/properties 06:53:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:53:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:53:56 INFO - Contents: 06:53:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:53:56 INFO - Running post-action listener: _resource_record_post_action 06:53:56 INFO - Running post-action listener: set_extra_try_arguments 06:53:56 INFO - ##### 06:53:56 INFO - ##### Running populate-webroot step. 06:53:56 INFO - ##### 06:53:56 INFO - Running pre-action listener: _resource_record_pre_action 06:53:56 INFO - Running main action method: populate_webroot 06:53:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:53:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:53:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:53:56 INFO - '--tppagecycles', 06:53:56 INFO - '7'], 06:53:56 INFO - 'tests': ['tsvgm']}}, 06:53:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:53:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:53:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:53:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:53:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'tests': ['damp', 'tps']}, 06:53:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['damp', 'tps']}, 06:53:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:53:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:53:56 INFO - 'other': {'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'other_l64': {'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'other_nol64': {'tests': ['a11yr', 06:53:56 INFO - 'ts_paint', 06:53:56 INFO - 'tpaint', 06:53:56 INFO - 'sessionrestore', 06:53:56 INFO - 'sessionrestore_no_auto_restore']}, 06:53:56 INFO - 'svgr': {'tests': ['tsvgx', 06:53:56 INFO - 'tsvgr_opacity', 06:53:56 INFO - 'tart', 06:53:56 INFO - 'tscrollx', 06:53:56 INFO - 'cart']}, 06:53:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['tsvgx', 06:53:56 INFO - 'tsvgr_opacity', 06:53:56 INFO - 'tart', 06:53:56 INFO - 'tscrollx', 06:53:56 INFO - 'cart']}, 06:53:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'tests': ['tp5o']}, 06:53:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'talos_options': ['--e10s'], 06:53:56 INFO - 'tests': ['tp5o']}, 06:53:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'talos_options': ['--xperf_path', 06:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:56 INFO - 'tests': ['tp5n']}, 06:53:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:53:56 INFO - 'talos_options': ['--e10s', 06:53:56 INFO - '--xperf_path', 06:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:53:56 INFO - 'tests': ['tp5n']}}, 06:53:56 INFO - 'talos.zip': {'path': '', 06:53:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:53:56 INFO - Running post-action listener: _resource_record_post_action 06:53:56 INFO - ##### 06:53:56 INFO - ##### Running create-virtualenv step. 06:53:56 INFO - ##### 06:53:56 INFO - Running pre-action listener: _resource_record_pre_action 06:53:56 INFO - Running main action method: create_virtualenv 06:53:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:53:56 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:53:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:53:56 INFO - Using real prefix '/usr' 06:53:56 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:53:56 INFO - Installing distribute.............................................................................................................................................................................................done. 06:53:58 INFO - Installing pip.................done. 06:53:58 INFO - Return code: 0 06:53:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:53:58 INFO - Using env: {'DISPLAY': ':0', 06:53:58 INFO - 'HOME': '/home/cltbld', 06:53:58 INFO - 'LANG': 'en_US.UTF-8', 06:53:58 INFO - 'LANGUAGE': 'en_US:en', 06:53:58 INFO - 'LOGNAME': 'cltbld', 06:53:58 INFO - 'MAIL': '/var/mail/cltbld', 06:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:58 INFO - 'MOZ_NO_REMOTE': '1', 06:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:58 INFO - 'NO_EM_RESTART': '1', 06:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:58 INFO - 'SHELL': '/bin/bash', 06:53:58 INFO - 'SHLVL': '1', 06:53:58 INFO - 'TERM': 'linux', 06:53:58 INFO - 'TMOUT': '86400', 06:53:58 INFO - 'USER': 'cltbld', 06:53:58 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:58 INFO - '_': '/tools/buildbot/bin/python'} 06:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:58 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:53:58 INFO - Cleaning up... 06:53:58 INFO - Return code: 0 06:53:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:53:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:53:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:53:58 INFO - Using env: {'DISPLAY': ':0', 06:53:58 INFO - 'HOME': '/home/cltbld', 06:53:58 INFO - 'LANG': 'en_US.UTF-8', 06:53:58 INFO - 'LANGUAGE': 'en_US:en', 06:53:58 INFO - 'LOGNAME': 'cltbld', 06:53:58 INFO - 'MAIL': '/var/mail/cltbld', 06:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:58 INFO - 'MOZ_NO_REMOTE': '1', 06:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:53:58 INFO - 'NO_EM_RESTART': '1', 06:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:53:58 INFO - 'PWD': '/builds/slave/test-pgo', 06:53:58 INFO - 'SHELL': '/bin/bash', 06:53:58 INFO - 'SHLVL': '1', 06:53:58 INFO - 'TERM': 'linux', 06:53:58 INFO - 'TMOUT': '86400', 06:53:58 INFO - 'USER': 'cltbld', 06:53:58 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:58 INFO - '_': '/tools/buildbot/bin/python'} 06:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:53:59 INFO - Downloading/unpacking psutil>=0.7.1 06:53:59 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:53:59 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:53:59 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:53:59 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:53:59 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:53:59 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:54:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:54:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:00 INFO - Installing collected packages: psutil 06:54:00 INFO - Running setup.py install for psutil 06:54:01 INFO - building 'psutil._psutil_linux' extension 06:54:01 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:54:01 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:54:01 INFO - building 'psutil._psutil_posix' extension 06:54:01 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:54:01 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:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:01 INFO - Successfully installed psutil 06:54:01 INFO - Cleaning up... 06:54:01 INFO - Return code: 0 06:54:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:01 INFO - Using env: {'DISPLAY': ':0', 06:54:01 INFO - 'HOME': '/home/cltbld', 06:54:01 INFO - 'LANG': 'en_US.UTF-8', 06:54:01 INFO - 'LANGUAGE': 'en_US:en', 06:54:01 INFO - 'LOGNAME': 'cltbld', 06:54:01 INFO - 'MAIL': '/var/mail/cltbld', 06:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:01 INFO - 'MOZ_NO_REMOTE': '1', 06:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:01 INFO - 'NO_EM_RESTART': '1', 06:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:01 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:01 INFO - 'SHELL': '/bin/bash', 06:54:01 INFO - 'SHLVL': '1', 06:54:01 INFO - 'TERM': 'linux', 06:54:01 INFO - 'TMOUT': '86400', 06:54:01 INFO - 'USER': 'cltbld', 06:54:01 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:01 INFO - '_': '/tools/buildbot/bin/python'} 06:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:03 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:54:03 INFO - Installing collected packages: mozsystemmonitor 06:54:03 INFO - Running setup.py install for mozsystemmonitor 06:54:03 INFO - Successfully installed mozsystemmonitor 06:54:03 INFO - Cleaning up... 06:54:03 INFO - Return code: 0 06:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:54:03 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:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:03 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:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:03 INFO - Using env: {'DISPLAY': ':0', 06:54:03 INFO - 'HOME': '/home/cltbld', 06:54:03 INFO - 'LANG': 'en_US.UTF-8', 06:54:03 INFO - 'LANGUAGE': 'en_US:en', 06:54:03 INFO - 'LOGNAME': 'cltbld', 06:54:03 INFO - 'MAIL': '/var/mail/cltbld', 06:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:03 INFO - 'MOZ_NO_REMOTE': '1', 06:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:03 INFO - 'NO_EM_RESTART': '1', 06:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:03 INFO - 'SHELL': '/bin/bash', 06:54:03 INFO - 'SHLVL': '1', 06:54:03 INFO - 'TERM': 'linux', 06:54:03 INFO - 'TMOUT': '86400', 06:54:03 INFO - 'USER': 'cltbld', 06:54:03 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:03 INFO - '_': '/tools/buildbot/bin/python'} 06:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:03 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:54:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:05 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:54:05 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:54:05 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:54:05 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:54:05 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:54:05 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:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:54:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 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:54:06 INFO - Downloading docopt-0.6.1.tar.gz 06:54:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:06 INFO - Running setup.py install for blobuploader 06:54:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:06 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:54:06 INFO - Running setup.py install for requests 06:54:06 INFO - Running setup.py install for docopt 06:54:06 INFO - Successfully installed blobuploader requests docopt 06:54:06 INFO - Cleaning up... 06:54:06 INFO - Return code: 0 06:54:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:06 INFO - Using env: {'DISPLAY': ':0', 06:54:06 INFO - 'HOME': '/home/cltbld', 06:54:06 INFO - 'LANG': 'en_US.UTF-8', 06:54:06 INFO - 'LANGUAGE': 'en_US:en', 06:54:06 INFO - 'LOGNAME': 'cltbld', 06:54:06 INFO - 'MAIL': '/var/mail/cltbld', 06:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:06 INFO - 'MOZ_NO_REMOTE': '1', 06:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:06 INFO - 'NO_EM_RESTART': '1', 06:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:06 INFO - 'SHELL': '/bin/bash', 06:54:06 INFO - 'SHLVL': '1', 06:54:06 INFO - 'TERM': 'linux', 06:54:06 INFO - 'TMOUT': '86400', 06:54:06 INFO - 'USER': 'cltbld', 06:54:06 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:06 INFO - '_': '/tools/buildbot/bin/python'} 06:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:07 INFO - Running setup.py (path:/tmp/pip-kgcEMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:07 INFO - Running setup.py (path:/tmp/pip-t0L16T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:07 INFO - Running setup.py (path:/tmp/pip-OBSzwk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:07 INFO - Running setup.py (path:/tmp/pip-DmoF7D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:07 INFO - Running setup.py (path:/tmp/pip-LmrOuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:07 INFO - Running setup.py (path:/tmp/pip-x5GnBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:07 INFO - Running setup.py (path:/tmp/pip-nIdEuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:07 INFO - Running setup.py (path:/tmp/pip-gNvsyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:07 INFO - Running setup.py (path:/tmp/pip-OiuYU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:07 INFO - Running setup.py (path:/tmp/pip-kNYqCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:07 INFO - Running setup.py (path:/tmp/pip-Z90nAD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:07 INFO - Running setup.py (path:/tmp/pip-pxNPXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:07 INFO - Running setup.py (path:/tmp/pip-1H_JwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:08 INFO - Running setup.py (path:/tmp/pip-ofndex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:08 INFO - Running setup.py (path:/tmp/pip-bJcssb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:08 INFO - Running setup.py (path:/tmp/pip-f1SNLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:08 INFO - Running setup.py (path:/tmp/pip-Fjk_o3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:08 INFO - Running setup.py install for manifestparser 06:54:08 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozcrash 06:54:08 INFO - Running setup.py install for mozdebug 06:54:08 INFO - Running setup.py install for mozdevice 06:54:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozfile 06:54:08 INFO - Running setup.py install for mozhttpd 06:54:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:54:08 INFO - Running setup.py install for mozinfo 06:54:09 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for mozInstall 06:54:09 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for mozleak 06:54:09 INFO - Running setup.py install for mozlog 06:54:09 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for moznetwork 06:54:09 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for mozprocess 06:54:09 INFO - Running setup.py install for mozprofile 06:54:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for mozrunner 06:54:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:54:09 INFO - Running setup.py install for mozscreenshot 06:54:09 INFO - Running setup.py install for moztest 06:54:09 INFO - Running setup.py install for mozversion 06:54:10 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:54:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:10 INFO - Cleaning up... 06:54:10 INFO - Return code: 0 06:54:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:10 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:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 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:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:10 INFO - Using env: {'DISPLAY': ':0', 06:54:10 INFO - 'HOME': '/home/cltbld', 06:54:10 INFO - 'LANG': 'en_US.UTF-8', 06:54:10 INFO - 'LANGUAGE': 'en_US:en', 06:54:10 INFO - 'LOGNAME': 'cltbld', 06:54:10 INFO - 'MAIL': '/var/mail/cltbld', 06:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:10 INFO - 'MOZ_NO_REMOTE': '1', 06:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:10 INFO - 'NO_EM_RESTART': '1', 06:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:10 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:10 INFO - 'SHELL': '/bin/bash', 06:54:10 INFO - 'SHLVL': '1', 06:54:10 INFO - 'TERM': 'linux', 06:54:10 INFO - 'TMOUT': '86400', 06:54:10 INFO - 'USER': 'cltbld', 06:54:10 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:10 INFO - '_': '/tools/buildbot/bin/python'} 06:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:10 INFO - Running setup.py (path:/tmp/pip-0iIUTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:10 INFO - Running setup.py (path:/tmp/pip-2ieFuc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:10 INFO - Running setup.py (path:/tmp/pip-qHlD6a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:10 INFO - Running setup.py (path:/tmp/pip-Yzgxlz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:10 INFO - Running setup.py (path:/tmp/pip-tffwOE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:10 INFO - Running setup.py (path:/tmp/pip-FjJ5gG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:10 INFO - Running setup.py (path:/tmp/pip-PxRyyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:10 INFO - Running setup.py (path:/tmp/pip-bOemKA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:10 INFO - Running setup.py (path:/tmp/pip-FG9EPX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:54:10 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:54:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:10 INFO - Running setup.py (path:/tmp/pip-YlK2Ee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:11 INFO - Running setup.py (path:/tmp/pip-YTbmxM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:11 INFO - Running setup.py (path:/tmp/pip-G2AtJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:11 INFO - Running setup.py (path:/tmp/pip-sujatv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 06:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:11 INFO - Running setup.py (path:/tmp/pip-GHFv_M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:11 INFO - Running setup.py (path:/tmp/pip-OmmBeM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:11 INFO - Running setup.py (path:/tmp/pip-uxgZB6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:54:11 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:54:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:11 INFO - Running setup.py (path:/tmp/pip-ji8uAi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:54:11 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:54:11 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:54:11 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:54:11 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:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 06:54:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:11 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:54:13 INFO - Downloading blessings-1.5.1.tar.gz 06:54:13 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:54:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:54:13 INFO - Installing collected packages: blessings 06:54:13 INFO - Running setup.py install for blessings 06:54:13 INFO - Successfully installed blessings 06:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:54:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:13 INFO - Reading from file tmpfile_stdout 06:54:13 INFO - Current package versions: 06:54:13 INFO - argparse == 1.2.1 06:54:13 INFO - blessings == 1.5.1 06:54:13 INFO - blobuploader == 1.2.4 06:54:13 INFO - docopt == 0.6.1 06:54:13 INFO - manifestparser == 1.1 06:54:13 INFO - mozInstall == 1.12 06:54:13 INFO - mozcrash == 0.16 06:54:13 INFO - mozdebug == 0.1 06:54:13 INFO - mozdevice == 0.47 06:54:13 INFO - mozfile == 1.2 06:54:13 INFO - mozhttpd == 0.7 06:54:13 INFO - mozinfo == 0.9 06:54:13 INFO - mozleak == 0.1 06:54:13 INFO - mozlog == 3.1 06:54:13 INFO - moznetwork == 0.27 06:54:13 INFO - mozprocess == 0.22 06:54:13 INFO - mozprofile == 0.27 06:54:13 INFO - mozrunner == 6.11 06:54:13 INFO - mozscreenshot == 0.1 06:54:13 INFO - mozsystemmonitor == 0.0 06:54:13 INFO - moztest == 0.7 06:54:13 INFO - mozversion == 1.4 06:54:13 INFO - psutil == 3.1.1 06:54:13 INFO - requests == 1.2.3 06:54:13 INFO - wsgiref == 0.1.2 06:54:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 06:54:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 06:54:13 INFO - Cleaning up... 06:54:13 INFO - Return code: 0 06:54:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:13 INFO - Using env: {'DISPLAY': ':0', 06:54:13 INFO - 'HOME': '/home/cltbld', 06:54:13 INFO - 'LANG': 'en_US.UTF-8', 06:54:13 INFO - 'LANGUAGE': 'en_US:en', 06:54:13 INFO - 'LOGNAME': 'cltbld', 06:54:13 INFO - 'MAIL': '/var/mail/cltbld', 06:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:13 INFO - 'MOZ_NO_REMOTE': '1', 06:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:13 INFO - 'NO_EM_RESTART': '1', 06:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:13 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:13 INFO - 'SHELL': '/bin/bash', 06:54:13 INFO - 'SHLVL': '1', 06:54:13 INFO - 'TERM': 'linux', 06:54:13 INFO - 'TMOUT': '86400', 06:54:13 INFO - 'USER': 'cltbld', 06:54:13 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:13 INFO - '_': '/tools/buildbot/bin/python'} 06:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:14 INFO - Downloading/unpacking jsonschema 06:54:14 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:54:14 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:54:14 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:54:14 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:54:14 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:54:14 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:54:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:54:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:54:15 INFO - Downloading/unpacking functools32 (from jsonschema) 06:54:15 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:54:15 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:54:15 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:54:15 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:54:15 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:54:15 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:54:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:54:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:54:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:54:16 INFO - warning: no files found matching '*.txt' 06:54:16 INFO - no previously-included directories found matching 'build' 06:54:16 INFO - no previously-included directories found matching 'dist' 06:54:16 INFO - no previously-included directories found matching '.git*' 06:54:16 INFO - Installing collected packages: jsonschema, functools32 06:54:16 INFO - Running setup.py install for functools32 06:54:16 INFO - warning: no files found matching '*.txt' 06:54:16 INFO - no previously-included directories found matching 'build' 06:54:16 INFO - no previously-included directories found matching 'dist' 06:54:16 INFO - no previously-included directories found matching '.git*' 06:54:16 INFO - Successfully installed jsonschema functools32 06:54:16 INFO - Cleaning up... 06:54:16 INFO - Return code: 0 06:54:16 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fdba91c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, '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': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', '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:54:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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:54:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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:54:16 INFO - Using env: {'DISPLAY': ':0', 06:54:16 INFO - 'HOME': '/home/cltbld', 06:54:16 INFO - 'LANG': 'en_US.UTF-8', 06:54:16 INFO - 'LANGUAGE': 'en_US:en', 06:54:16 INFO - 'LOGNAME': 'cltbld', 06:54:16 INFO - 'MAIL': '/var/mail/cltbld', 06:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:16 INFO - 'MOZ_NO_REMOTE': '1', 06:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:16 INFO - 'NO_EM_RESTART': '1', 06:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:16 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:16 INFO - 'SHELL': '/bin/bash', 06:54:16 INFO - 'SHLVL': '1', 06:54:16 INFO - 'TERM': 'linux', 06:54:16 INFO - 'TMOUT': '86400', 06:54:16 INFO - 'USER': 'cltbld', 06:54:16 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:16 INFO - '_': '/tools/buildbot/bin/python'} 06:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:16 INFO - Downloading/unpacking flake8 06:54:16 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:54:16 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:54:16 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:54:16 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:54:16 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:54:16 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:54:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:54:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:54:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:54:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 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:54:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:54:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:18 INFO - no previously-included directories found matching 'docs/_build' 06:54:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:54:18 INFO - Running setup.py install for pep8 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:54:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:54:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:54:18 INFO - no previously-included directories found matching 'docs/_build' 06:54:19 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:54:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:54:19 INFO - Cleaning up... 06:54:19 INFO - Return code: 0 06:54:19 INFO - Running post-action listener: _resource_record_post_action 06:54:19 INFO - Running post-action listener: _start_resource_monitoring 06:54:19 INFO - Starting resource monitoring. 06:54:19 INFO - ##### 06:54:19 INFO - ##### Running install step. 06:54:19 INFO - ##### 06:54:19 INFO - Running pre-action listener: _resource_record_pre_action 06:54:19 INFO - Running main action method: install 06:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:54:19 INFO - Reading from file tmpfile_stdout 06:54:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:54:19 INFO - Reading from file tmpfile_stdout 06:54:19 INFO - Output received: 06:54:19 INFO - Usage: mozinstall [options] installer 06:54:19 INFO - Options: 06:54:19 INFO - -h, --help show this help message and exit 06:54:19 INFO - -d DEST, --destination=DEST 06:54:19 INFO - Directory to install application into. [default: 06:54:19 INFO - "/builds/slave/test-pgo"] 06:54:19 INFO - --app=APP Application being installed. [default: firefox] 06:54:19 INFO - mkdir: /builds/slave/test-pgo/build/application 06:54:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 06:54:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 06:54:34 INFO - Reading from file tmpfile_stdout 06:54:34 INFO - Output received: 06:54:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:54:34 INFO - Running post-action listener: _resource_record_post_action 06:54:34 INFO - ##### 06:54:34 INFO - ##### Running run-tests step. 06:54:34 INFO - ##### 06:54:34 INFO - Running pre-action listener: _resource_record_pre_action 06:54:34 INFO - Running main action method: run_tests 06:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:54:34 INFO - Python 2.7.3 06:54:34 INFO - Return code: 0 06:54:34 INFO - grabbing minidump binary from tooltool 06:54: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:54:34 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 0x2240350>, '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 0x2241250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22416e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:54:34 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:54:34 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:54:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:54:34 INFO - Return code: 0 06:54:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:54:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:54:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:54:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:54:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:54:35 INFO - Return code: 0 06:54:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 06:54:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 06:54:35 INFO - Using env: {'DISPLAY': ':0', 06:54:35 INFO - 'HOME': '/home/cltbld', 06:54:35 INFO - 'LANG': 'en_US.UTF-8', 06:54:35 INFO - 'LANGUAGE': 'en_US:en', 06:54:35 INFO - 'LOGNAME': 'cltbld', 06:54:35 INFO - 'MAIL': '/var/mail/cltbld', 06:54:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:35 INFO - 'MOZ_NO_REMOTE': '1', 06:54:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:54:35 INFO - 'NO_EM_RESTART': '1', 06:54:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:54:35 INFO - 'PWD': '/builds/slave/test-pgo', 06:54:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:54:35 INFO - 'SHELL': '/bin/bash', 06:54:35 INFO - 'SHLVL': '1', 06:54:35 INFO - 'TERM': 'linux', 06:54:35 INFO - 'TMOUT': '86400', 06:54:35 INFO - 'USER': 'cltbld', 06:54:35 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450361321.440923-970615544', 06:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:35 INFO - '_': '/tools/buildbot/bin/python'} 06:54:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 06:54:35 INFO - mozversion INFO | application_buildid: 20151217043003 06:54:35 INFO - mozversion INFO | application_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 06:54:35 INFO - mozversion INFO | application_display_name: Nightly 06:54:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:54:35 INFO - mozversion INFO | application_name: Firefox 06:54:35 INFO - mozversion INFO | application_remotingname: firefox 06:54:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 06:54:35 INFO - mozversion INFO | application_vendor: Mozilla 06:54:35 INFO - mozversion INFO | application_version: 46.0a1 06:54:35 INFO - mozversion INFO | platform_buildid: 20151217043003 06:54:35 INFO - mozversion INFO | platform_changeset: f143af51f6e35932927b8ccac2509facbbe7b539 06:54:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 06:54:35 INFO - mozversion INFO | platform_version: 46.0a1 06:54:35 INFO - 2015-12-17 06:54:35,532 DEBUG : using testdate: 1450364075 06:54:35 INFO - 2015-12-17 06:54:35,532 DEBUG : actual date: 1450364075 06:54:35 INFO - 2015-12-17 06:54:35,540 INFO : starting webserver on 'localhost:46320' 06:54:35 INFO - 2015-12-17 06:54:35,541 INFO : Starting test suite talos-linux64-ix-042 06:54:35 INFO - 2015-12-17 06:54:35,541 INFO : Starting test dromaeo_css 06:54:35 INFO - 2015-12-17 06:54:35,541 DEBUG : operating with platform_type : linux_ 06:54:35 INFO - 2015-12-17 06:54:35,542 INFO : Initialising browser for dromaeo_css test... 06:54:35 INFO - 2015-12-17 06:54:35,553 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbJs1Uw/profile http://localhost:46320/getInfo.html 06:54:39 INFO - 2015-12-17 06:54:39,799 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:54:39 INFO - 2015-12-17 06:54:39,799 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:54:39 INFO - 2015-12-17 06:54:39,799 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:54:39 INFO - 2015-12-17 06:54:39,799 DEBUG : BROWSER_OUTPUT: __metrics 06:54:39 INFO - 2015-12-17 06:54:39,895 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:54:39 INFO - 2015-12-17 06:54:39,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:54:39 ERROR - 2015-12-17 06:54:39,959 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 06:54:41 INFO - 2015-12-17 06:54:41,022 INFO : Browser initialized. 06:54:41 INFO - 2015-12-17 06:54:41,023 INFO : Running cycle 1/1 for dromaeo_css test... 06:54:41 INFO - 2015-12-17 06:54:41,023 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbJs1Uw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:54:52 INFO - 2015-12-17 06:54:52,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 142434304 06:54:52 INFO - 2015-12-17 06:54:52,887 DEBUG : BROWSER_OUTPUT: 06:55:44 INFO - 2015-12-17 06:55:44,374 DEBUG : BROWSER_OUTPUT: 1450364144372 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:57:52 INFO - 2015-12-17 06:57:52,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46320/tests/dromaeo/cssquery-ext.html) 06:57:53 INFO - 2015-12-17 06:57:53,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 233721856 06:57:53 INFO - 2015-12-17 06:57:53,997 DEBUG : BROWSER_OUTPUT: 07:00:56 INFO - 2015-12-17 07:00:56,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-ext.html (next: http://localhost:46320/tests/dromaeo/cssquery-jquery.html) 07:00:56 INFO - 2015-12-17 07:00:56,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 223678464 07:00:56 INFO - 2015-12-17 07:00:56,781 DEBUG : BROWSER_OUTPUT: 07:03:58 INFO - 2015-12-17 07:03:58,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46320/tests/dromaeo/cssquery-mootools.html) 07:03:59 INFO - 2015-12-17 07:03:59,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 218337280 07:03:59 INFO - 2015-12-17 07:03:59,271 DEBUG : BROWSER_OUTPUT: 07:07:01 INFO - 2015-12-17 07:07:01,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46320/tests/dromaeo/cssquery-prototype.html) 07:07:01 INFO - 2015-12-17 07:07:01,719 DEBUG : BROWSER_OUTPUT: RSS: Main: 205094912 07:07:01 INFO - 2015-12-17 07:07:01,719 DEBUG : BROWSER_OUTPUT: 07:10:04 INFO - 2015-12-17 07:10:04,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46320/tests/dromaeo/cssquery-yui.html) 07:10:04 INFO - 2015-12-17 07:10:04,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 207106048 07:10:04 INFO - 2015-12-17 07:10:04,775 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/dromaeo/cssquery-yui.html (next: http://localhost:46320/tests/dromaeo/cssquery-dojo.html) 07:13:07 INFO - 2015-12-17 07:13:07,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 259969024 07:13:07 INFO - 2015-12-17 07:13:07,494 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,494 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:13:07 INFO - 2015-12-17 07:13:07,495 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:13:07 INFO - 2015-12-17 07:13:07,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:13:07 INFO - 2015-12-17 07:13:07,496 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:13:07 INFO - 2015-12-17 07:13:07,497 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3101.0851798719377;3142.135912624027;3183.029176101288;3184.4586420308547;3193.377291428171;5095;5232.3459567554055;5339.626226164165;5342.439043900393;5404.405515393303;5180.948190518094;5235.712035838027;5235.816746413867;5289.867753306169;5304.071787437202;4787.425508938933;4806.255030470283;4822.252550854623;4834.202356611155;4860.4896485869;4960.801567937278;4967.453580106186;4974.8258810941625;4980.750962451881;5014.323066386028;4705.600023997964;4806.687565308243;4811.9037619247765;4903.436104847952;4925.901481970341;4879.8780030499165;4884.047610715912;4917;4931.679440836334;4936.90126197474;4835.854924352275;4875.756212189412;4876.756162191876;4883.536064073907;4916.877078073041;5062.898742025176;5085.669431486942;5203.765830537635;5205.505476979681;5207.583393328562;5768.596198266123;5774.047282198432;5775.133729940542;5782.3350314713925;5790.7394167262155;5787.074068149118;5807.332156801937;5812.302523697141;5812.476877081083;5812.709364531756;5253.527182553588;5326.92009619856;5336.946630533723;5338.386085600167;5392.352917649829;5808.07070868659;5909.202257695242;5910.7931222407005;5922.526197904157;5967.850803729942;5735.369109397963;5737.799177028784;5749.453801888814;5749.913751293734;5751.4536119068625;5486.91769623456;5528.308961379827;5569.19246709233;5698.6580805151825;5805.274340707411;5697.0599851024945;5797.188393624896;5801.12983052537;5808.854778630483;5810.535157187415;5791.189233507313;5791.652500849962;5792;5793.362730099686;5797.652140871477;4339.63113135387;4400.669949753717;4408.713433626804;4463.196624607602;4491.483479399845;3984.7011474139554;4001.5398229203433;4002.579729128458;4034.8789536313957;4045.6561192298986;5470.753816078286;5483.4516548344845;5483.890322193533;5489.752961116759;5529.281193444826;5503.257060296889;5533.418991005887;5588.050031494656;5603.719814009283;5845.064789633723;5244.580433565306;5347;5352.330958630171;5357;5362.597805164551;4995.350604421475;5025.070361983045;5025.346704928409;5027.4218464877;5071.366079240095;5625.578081643893;5724.971375143097;5839.386864379264;5853.795117170878;5859.853503662443;5734.713264336683;5810.389909059488;5889.440503152194;5892.381299963442;5920.171176035445;5856.385079566584;5859.326177489473;5862;5864.824055278348;5865.706714664335;5513.062779327604;5620.353659329229;5648.943510564842;5700.25896633435;5712.171735098304;5688.431156884279;5690.459406356389;5717.056685646988;5727.513161381329;5729.656220626775;5523.585731070106;5560.221568980265;5602.579806514446;5608.747606357805;5609.859753506195;5680.886382272414;5709.8287051388525;5713.371529131875;5716.399778023248;5720.342160651412;5346.572274218131;5600.915986260128;5602.13166959122;5604.551635869039;5606.074997625346;5544;5560;5569.331680198402;5628.74670639814;5676.063449530781;5547.583931205095;5548.805791797429;5553.333599968029;5554.555635549065;5598.356189038313 07:13:07 INFO - 2015-12-17 07:13:07,499 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.2100948167825;588.493895250085;596.4572239262272;597.7818096394815;597.8744463662631;29542.852285738594;37382.252354952885;37854.621453785454;37886.43170352447;37925.43111853321;41773.16453670932;42283.15433691324;42357.78821105898;42427.363589546105;42508.57491425085;7551.962240188791;7661.157272699998;8690.826183476342;8846.071162527938;8858;10353.327033742782;10596.099331556788;10606.15150787935;10607.575696972111;10611.84082238767;10317.380957142557;10429.73925651861;10437.582496700123;10440.060394564487;10440.112590429822;7768.611569421506;7900.446968712193;7902.881456778125;10307.742306442324;10490.265681402228;10019.298649094566;10151.340162889463;10153.136983356424;10156.035176658206;10163.59345626174;39025;39501.60498395037;39533.60466395357;39547.20905581872;39566.406503902464;3184.8248346340943;3209.8555564999633;3235.9191020224685;3289.3256882339065;3615.963840361589;29685.554716679268;29959;30121.700317327482;30576.08271751851;31055;3909.706771992112;3917.2948869203533;3947.605239476058;3983.601639836022;4049.2913740095364;253927;256823;257001;257100;258217;54779;55158;55176.72411637916;55185.448145518836;55193.44806551963;56620.71689641608;57817.4218257812;64412.677936610955;65426;65687.34312656813;13124.409401576951;13132.934335328262;13227.867721322857;13238.338083095807;13238.404271807793;9623.711288661352;9626.326157169071;9626.855597166048;9631.181349585364;9642.180414664692;18567.35014274521;18718.625627487374;18733.718994215098;18794.248230070916;18824.717629235573;7056.259092795285;7358.632068396559;7358.718797172894;7448.813779655552;7456.701731930662;939.3283802081545;958.3195930889008;1009.2531526670358;1065.898739619735;1095.3865835132192;22249.11003559872;22440;22480;23440.64839027416;23569.410764730677;1094.316052467208;1120.3669926491507;1132.8470656461436;1136.4772204785727;1166.6033548593518;13959.581212563638;14058.71882562343;14196;14255.429782808778;14276.85723142776;294184;296674;297147;297220;297410;50730.74634626803;50767;50898.74550627297;51046.48953510417;51197.488025120016;1340.544214966916;1354.3228385807097;1361.673198432389;1366.5695305978586;1373.8420081690733;25953.480930381666;27113.373197608205;27177.59233611458;27187.72812271852;27760;42515.7874210627;43143.78428107965;47424;47532;47825.521744782105;413676;418390;420780;420849;421088;30864.228394289425;31337.373252534366;31344.843275784388;31356.372872542877;31384.372312553165;42675;43055.354169686856;43095.35356969585;43313;44072.11855762931;36283.24331886162;36661.45007824938;36776.44835327419;37154.628453715115;37779.244415110996;35310;36010;36517.08707282233;36849.447258291686;37612.2477550442;26435.867820660773;26440.338991525365;26466.735332646425;26484.337891552866;26648.8667556661;27570;27918.581221281293;29958.450476451642;32086.83956580202;32315.838420807744;24362.147324843547;24432.267031989068;24497.75502245026;24681.876590616932;24800.379990500383 07:13:07 INFO - 2015-12-17 07:13:07,502 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.20086000907895;345.6750654384878;346.9107004007417;347.3365871186035;347.4492928707997;13729.107608005497;14041.859581404184;16032.198390080493;16486.917565412172;17148.742768858476;15649.92175039126;15664;16288.10415427151;16306.266218020188;16308.347666093372;5023.623228257877;5348.705821179834;5354.437784032679;5356.625036247464;5357.357117145929;3927.17529318842;4041.0301527633305;5272.340957380327;5783.161441590967;5957.434043765857;5854.619449735775;5884.440978107094;5895.145203945425;5900.144479050535;5900.852478688024;5766.452187042224;5858.882822343529;5898.528117750569;5904.055351143839;5905.763769449239;5179.689218646856;5205.479452054802;5218.921716174261;5233.581313494911;5234.476552344773;12307.384630768514;12675.936620316932;12686.55597054108;12691.365431728376;20337.694934575993;2069.1309649947057;2086.540960988595;2172.8044475997235;2388.8805559721945;2518.508890766301;9497.097775711365;9513.524323783784;9622.807543849154;9703.708888733348;9851.408915465096;1843.271907596492;1857.8978156201404;1860.944171674852;1870.326682394337;1874.3627166763365;60169.6991515044;61023.69488152575;61296.693516532134;61996.38003619996;63286.0507092394;10287.897121028844;10306.896931030744;10309.123724483354;10407.94796026015;10410.323328983592;13601.455941762219;13631.182129072287;13634.590962271148;13660.043796934318;13669.179849209078;7184.281571842774;7216.819579510554;7250.927490725026;7290.161631412349;7323.523970941872;6829.69266383004;6836.418904393182;6839;6846.075779769767;6872.278410766898;4405.515393306734;4462.464504259509;4480.887977800581;4511.187986162522;4515.412996310459;1690.9746353804703;1754.2632094520332;1769.469159252245;1825.954351141232;1846.6583682018602;970.3547141151197;988.6539711101201;1003.9648612298535;1028.3521381529588;1031.9638812641522;14499.637509062359;16297.918510407371;16525.6694866102;16732.498025059023;17334.219960101826;874.1084094223983;923.9029901860208;929.8279818233649;968.4286271099944;979.2313034268066;8995.415298005608;9226;9259.30555208362;9292.229258772464;9423.811523769486;526994;543305;558003;558016;560006;81795.59102204451;82429;83799.5810020946;84427.15572844316;85339;1073.8228192348174;1100.1913593508764;1103.9503222355013;1129.5989923577013;1149.6953307373553;14952.925235373754;15857.127857967922;16248.26882790301;16297.837021629632;16489.67020659556;37219.8139009314;37539.81230093941;38162.61837381591;38463.807680961414;38766.4185037219;49852;51553.742231288605;51806.48193518016;52851.68447410615;54226;9429.575669095044;9764.316497845082;9868.703938881845;9874.92626548433;9941.552630131517;11613.883861161617;11803.409829508319;11813.645590632295;11823.11326650522;12536.623901282976;14357.712845742817;14578.343974521384;14613.561593152222;14777.408903643734;14855.777163342775;14598.416063357772;14610.926945365205;14772.261386930826;15030.795504901644;15382.923085384502;15049.322780475124;15273.465428709942;15384.923075384551;15721.135337556545;15931.60170995688;9856.31005829585;9872.160866326443;10058.446785426871;10081.243906707174;10085.092341689284;14800;14808.7778683322;15117.622059448602;15205.31576079057;15323.157226352658 07:13:07 INFO - 2015-12-17 07:13:07,504 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.746778112158;1745.5636090977255;1756.8331008554183;1792.8027916929143;1816.5549440387103;6720.2943690912425;7535.736249231278;7647.426443016768;7659.540427574349;7667.3866090712745;7523.510971786844;7717.807054823632;7763.107242667095;7791.883121753164;7792.883106753403;1975.6443840108846;2019.0207749241606;2020.3130935481934;2218.5119273759747;2261.796438320551;2195.6596727507263;2231.4532939429782;2231.654093615492;2232.6651002349695;2239.0595949701083;2169.8155656769195;2193.1994821889975;2222.7666095060026;2223.8776867272295;2224.5662095891307;2199.0763879170786;2232.0402227042364;2239.9440013999697;2270.1373478078226;2271.3867255840914;2215.423989762657;2232.9888350558304;2255.954880902389;2258.525709600986;2260.626996545568;7716.498427602244;7802.297793198582;7806.921930780733;7812.414068944795;7817.179196184433;4505.459344878603;4555.612772914306;4571.474280457756;4573.176828170928;4590.311453282001;2960.156355438711;3062.4028314478687;3074.3851229754137;3091;3106.5340198970334;933.6498812945146;941.0495399646406;947.3794664494767;949.1979277510493;970.403202030753;10725.088367488774;10782.676519704342;10785.13718902486;10794;10837.295575787548;4080.2655522006326;4116.938245926313;4168.187203495289;4188.099558594917;4202.03353228753;9083.318751093695;9166.312526560534;9175.678851240307;9179.311551633655;9186.356955013218;4536.500984891659;4549.931751023737;4575.130725162275;4587.79354929029;4596.47140578831;4085.3667681509414;4107.691923105779;4117.300058989979;4123.567025462284;4126.0097576582;3076.32320889404;3110.0980715592223;3382.30662714143;3592.317459682652;3664.230511592542;1132.8867113288604;1144.856892888389;1145.604766355606;1145.667756350649;1153.7288737146764;1074.119222237773;1075.6020272499225;1128.4245035032193;1251.6432816647393;1365.337811161586;7344.192138864721;7405.925940740523;7422.072240969879;7476.663550140257;7485.7754267372065;1129.265977114882;1133.1614605192262;1138.2698298586104;1147.1052578988401;1155.9190856640123;5816.534677225812;5898.351181370046;5901.29184497863;5903.911441328383;5905.173275741399;9106.362554621246;9215.400998935182;9222.723318300461;9315.906840931639;9360.812783744286;9185.908140918638;9212.907870921204;9236.67671631503;9240.815183696423;9243.445393276425;7288.198298187195;7317.938898859636;7406.925930740624;7483.438742094474;7483.6258187090425;7430.145533263744;7489.363404110493;7503.474756766974;7504.362129219077;7505.624718763931;8066.556339401389;8140.104588495379;8261.793455163428;8368;8378.413511054168;8476.321894248322;8486.236238738544;8505.23452889243;8509.74470765878;8638.481691098554;6650.401463868275;6769.356911093439;6773.322667733188;6799.5920244785475;6807.285235050446;6506.642134682638;6695.497837662292;6935.479839011993;7150.320719531636;7345.522541034816;6989.650517474208;7003.159620845531;7116.43068554504;7223.458240631869;7237.63811809418;6900.861982760216;6903.89644155328;6989.965050174716;7074.434045276263;7093.82265443368;7137.607431591312;7148.320909513588;7171.820704482429;7182.96408517954;7189.317014883578;6463.224413070461;6634.071230027704;6643.667816609247;6649.102371180023;6657.900131497934;6493.350664933469;6521.087047813215;6537.378948999837;6563.146790917151;6568.540202185801 07:13:07 INFO - 2015-12-17 07:13:07,505 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.9712025917667;334.35970117225514;337.5106096160568;338.8932486266826;343.53108007569676;5866.2080619116405;6021.909671354933;6074.665893375868;6124.969375153124;6138.109974053759;5773;5954.374790646984;5972.0444728843395;5990.041593345066;6006.579539432241;4657.394538709963;4658.277966915117;4659.906801863961;4661.09108723799;4666.136764698542;4443.044745379742;4555.792714930546;4564.109998550284;4572.245579479382;4660.86017419478;4476.261416866213;4531.56950089741;4541.296099104644;4555.157295900269;4564.201264778667;4581.908361832761;4589.35748995141;4590.219662657356;4614.653900957442;4620.330052142437;4021.155557332964;4041.939370909439;4066.837326506966;4068.2677118118727;4071.6742660587083;5617.4382561743905;5735.397783232742;5739.684317362585;5804.216430781833;5822.912656310159;5310.070737620901;5334.146536554172;5340.279062326575;5349.063913815066;5354.759035843357;6025.78909738157;6414.550981431302;6419.51853610981;6424.518161137933;6425.742970281183;4254.680898932593;4298.78506074695;4368.191884501346;4370.38814565961;4382.9838274393815;6379.266384365765;6465.903011454832;6469.417752402259;6471.061696054046;6475.255345635218;4425.557444255549;4466.2630665940405;4469.41897553316;4474.418325617649;4478.753668548261;4447.3329000650165;4478.350639157369;4523.231050721385;4523.751193684313;4530.88672783183;5221.791128354823;5222.112240919053;5231.581473482112;5232.869178270574;5236.607254455931;6296.961001434712;6305;6308.905366419507;6309.810705678837;6310;1576.9763453548205;1584.3345794766226;1586.2068965517242;1587.6904003719394;1589.3007076886133;1059.7774467361787;1067.0876400677464;1071.3571856885962;1074.854894589236;1094.6934858239706;6172.660503672341;6172.969135154295;6175.660338681416;6175.84560385985;6182.258129024456;6611.20665520131;6612.9749888766355;6616.27221005689;6620.3710647488415;6632.0383544385795;6030.33666296707;6172.9074063889075;6174.043023331391;6174.44430001302;6181.8454538636;3565.2691198304287;3596.2627661329366;3596.5684117906017;3599.94600080999;3600.7299452541165;6705.1283333166375;6709.597424154566;6709.865802683919;6714.429273511806;6718.966405167943;6652.501062420241;6721.93278067213;6781.6609169541325;6789.796306110825;6799.184097908283;6737.090492783412;6739.427148692318;6744.62904540255;6747.730090796314;6757.425618822455;6432.2602900667025;6598.538102332983;6623.867522649423;6646.268910419753;6650.46796256308;6401.775937842153;6602.40578347951;6603.174603174603;6617.636030018395;6635;6795.490338224752;6797.864042719217;6802.285759995327;6803.387695107464;6803.659817009031;4429.269170586946;4446.577575130357;4525.230710779241;4535.387722657399;4556.977215113903;6651.26836048044;6687.926742709776;6690.1971763386755;6697.832554186184;6706.128203333536;6496.058071579689;6514.218293804774;6519.152510173647;6521.282658907421;6522.05430212626;6276.74893004293;6477.287498375269;6481.319461456479;6489.805305840832;6508.284088750328;6390.7763228286785;6401.29585745577;6402.551821372459;6407.391297826699;6409.166808314889;6545.5090868184125;6549.148610680581;6549.803505894831;6554.2462616797775;6558.147440832661;6233.314335423009;6335.239771227482;6375.4262116409745;6389.9361006389345;6392.264889537577 07:13:07 INFO - 2015-12-17 07:13:07,506 DEBUG : BROWSER_OUTPUT: |5;yui.html;708.4898872811574;712.8788106021975;729.8941653460245;743.4275607782005;826.7974346285159;13766.862331376684;13927.791083133736;13969.441222351094;14027.088239264453;14031.5088971886;12783.169094008883;13021.28382938938;13109.541166059189;13123.73752524949;13635.250061246628;824.7402068348481;837.8324335132967;839.9244068033876;839.937004724645;841.188253335531;822.5722624235394;826.4834478450969;831.4221615976899;831.9376046796484;832.8375966686499;869.3088994249555;876.0669886570813;879.0111124984393;879.3712495565669;880.2561835249204;873.7422460374205;876.6230520876021;877.171073335698;877.5085951866943;878.376352789517;635.1425575473074;638.2819328255713;638.4158494977137;638.4732595608641;639.5043841023198;11153.442327883573;11283.548658053667;11324.433778311051;11427.942860285728;11430.085593152528;10720;10949.397783121925;11020.44897755109;11102;11136.053435457996;9983.101520863158;9992.350497217658;10036.14692751117;10134.23993200513;10462.110720588758;3455.3780319542725;3476.1309672581856;3527.0476971217627;3537.239493508908;3602.9279414411826;42260.57739422597;42952;43031.56968430307;43058.784706076585;45383.546164538595;6899.323464398159;9872.703818885446;10908.018278354828;10958;11426.714332141597;18560.25758969653;18723.344682936033;18777.81222187788;18780.342688005854;18784.154713037948;7555.697772089165;7558.206388329256;7595.734149304748;7898.486598371088;7933.880991785128;4358.3244597087505;4403.163398954189;4443.155800397914;4455.688101832905;4476.328550717419;3145.072203699914;3165.6201255849446;3171.2864605463587;3173.587433633613;3175.7618178636694;510.5660188839457;534.1907010878522;554.9583781216425;591.2786400591272;602.2682440834408;507.18090284190765;529.6001518853241;541.4531323363352;590.8788698316835;597.2922087326446;8173.877391839127;8358.498490090615;8540.53027083504;8590.699325523577;8707.47755134694;484.20590232019515;597.1513594881037;654.7184710574498;656.3305428462941;671.1945665201778;3990.4413382125945;4023.6982226333143;4036;4046.069404037088;4062.878113656595;59490.70254648699;60287.69856150779;60414.09378859321;60514.092288615706;60633.09050364248;50646.74676626593;52219.73890130601;52421.73789131106;52805.2079218812;52982.47017529853;42324.36513452239;43361.783191084476;46668.76665616718;47107.528924710314;47989.28016079831;8817.823643527221;9134.184476268123;9170.954145229498;9196.114796466842;9207.125323094295;35658.28683426369;35759.28481430305;35819.10452238715;36685.81657091698;36721.81639091788;38507.80746096364;42521.57478425176;42574.78712606417;45415.77292113518;47209.76395118002;10549.314294570828;10666.62666806689;10811.6215932442;10834.349939003685;11077;11782.469788859693;11809.82285265739;12528.123031387715;12640;13069.346532673138;10858.185636077484;10952.56189752401;11239.213255072067;11393.886061139283;11696.649100526998;10937.343759374464;11454;11570.305781653127;11641.41792910368;11761.176717629683;11297.491612877277;11446.484908179318;11712.355820429959;11941.104417168573;12022.579209727617;9817.852732209165;9832.950835246063;10035.14701250402;10086.697399078039;10123.79752404933;9007.549622518978;9384.57769400365;9533.142017218484;9930.205583553443;10237.641682541076 07:13:07 INFO - 2015-12-17 07:13:07,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:13:07 INFO - 2015-12-17 07:13:07,506 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:13:07 INFO - 2015-12-17 07:13:07,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1204 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365187494__endTimestamp 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,507 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5326.17 Median:5544.00 stddev:590.09 (10.6%) stddev-sans-first:565.50 07:13:07 INFO - 2015-12-17 07:13:07,508 DEBUG : BROWSER_OUTPUT: Values: 3101.1 3142.1 3183.0 3184.5 3193.4 5095.0 5232.3 5339.6 5342.4 5404.4 5180.9 5235.7 5235.8 5289.9 5304.1 4787.4 4806.3 4822.3 4834.2 4860.5 4960.8 4967.5 4974.8 4980.8 5014.3 4705.6 4806.7 4811.9 4903.4 4925.9 4879.9 4884.0 4917.0 4931.7 4936.9 4835.9 4875.8 4876.8 4883.5 4916.9 5062.9 5085.7 5203.8 5205.5 5207.6 5768.6 5774.0 5775.1 5782.3 5790.7 5787.1 5807.3 5812.3 5812.5 5812.7 5253.5 5326.9 5336.9 5338.4 5392.4 5808.1 5909.2 5910.8 5922.5 5967.9 5735.4 5737.8 5749.5 5749.9 5751.5 5486.9 5528.3 5569.2 5698.7 5805.3 5697.1 5797.2 5801.1 5808.9 5810.5 5791.2 5791.7 5792.0 5793.4 5797.7 4339.6 4400.7 4408.7 4463.2 4491.5 3984.7 4001.5 4002.6 4034.9 4045.7 5470.8 5483.5 5483.9 5489.8 5529.3 5503.3 5533.4 5588.1 5603.7 5845.1 5244.6 5347.0 5352.3 5357.0 5362.6 4995.4 5025.1 5025.3 5027.4 5071.4 5625.6 5725.0 5839.4 5853.8 5859.9 5734.7 5810.4 5889.4 5892.4 5920.2 5856.4 5859.3 5862.0 5864.8 5865.7 5513.1 5620.4 5648.9 5700.3 5712.2 5688.4 5690.5 5717.1 5727.5 5729.7 5523.6 5560.2 5602.6 5608.7 5609.9 5680.9 5709.8 5713.4 5716.4 5720.3 5346.6 5600.9 5602.1 5604.6 5606.1 5544.0 5560.0 5569.3 5628.7 5676.1 5547.6 5548.8 5553.3 5554.6 5598.4 07:13:07 INFO - 2015-12-17 07:13:07,508 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,508 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:48205.00 Median:17648.35 stddev:87356.12 (495.0%) stddev-sans-first:87527.93 07:13:07 INFO - 2015-12-17 07:13:07,508 DEBUG : BROWSER_OUTPUT: Values: 562.2 588.5 596.5 597.8 597.9 29542.9 37382.3 37854.6 37886.4 37925.4 41773.2 42283.2 42357.8 42427.4 42508.6 7552.0 7661.2 8690.8 8846.1 8858.0 10353.3 10596.1 10606.2 10607.6 10611.8 10317.4 10429.7 10437.6 10440.1 10440.1 7768.6 7900.4 7902.9 10307.7 10490.3 10019.3 10151.3 10153.1 10156.0 10163.6 39025.0 39501.6 39533.6 39547.2 39566.4 3184.8 3209.9 3235.9 3289.3 3616.0 29685.6 29959.0 30121.7 30576.1 31055.0 3909.7 3917.3 3947.6 3983.6 4049.3 253927.0 256823.0 257001.0 257100.0 258217.0 54779.0 55158.0 55176.7 55185.4 55193.4 56620.7 57817.4 64412.7 65426.0 65687.3 13124.4 13132.9 13227.9 13238.3 13238.4 9623.7 9626.3 9626.9 9631.2 9642.2 18567.4 18718.6 18733.7 18794.2 18824.7 7056.3 7358.6 7358.7 7448.8 7456.7 939.3 958.3 1009.3 1065.9 1095.4 22249.1 22440.0 22480.0 23440.6 23569.4 1094.3 1120.4 1132.8 1136.5 1166.6 13959.6 14058.7 14196.0 14255.4 14276.9 294184.0 296674.0 297147.0 297220.0 297410.0 50730.7 50767.0 50898.7 51046.5 51197.5 1340.5 1354.3 1361.7 1366.6 1373.8 25953.5 27113.4 27177.6 27187.7 27760.0 42515.8 43143.8 47424.0 47532.0 47825.5 413676.0 418390.0 420780.0 420849.0 421088.0 30864.2 31337.4 31344.8 31356.4 31384.4 42675.0 43055.4 43095.4 43313.0 44072.1 36283.2 36661.5 36776.4 37154.6 37779.2 35310.0 36010.0 36517.1 36849.4 37612.2 26435.9 26440.3 26466.7 26484.3 26648.9 27570.0 27918.6 29958.5 32086.8 32315.8 24362.1 24432.3 24497.8 24681.9 24800.4 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29224.37 Median:18783.63 stddev:89888.66 (478.5%) stddev-sans-first:90114.67 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: Values: 345.2 345.7 346.9 347.3 347.4 13729.1 14041.9 16032.2 16486.9 17148.7 15649.9 15664.0 16288.1 16306.3 16308.3 5023.6 5348.7 5354.4 5356.6 5357.4 3927.2 4041.0 5272.3 5783.2 5957.4 5854.6 5884.4 5895.1 5900.1 5900.9 5766.5 5858.9 5898.5 5904.1 5905.8 5179.7 5205.5 5218.9 5233.6 5234.5 12307.4 12675.9 12686.6 12691.4 20337.7 2069.1 2086.5 2172.8 2388.9 2518.5 9497.1 9513.5 9622.8 9703.7 9851.4 1843.3 1857.9 1860.9 1870.3 1874.4 60169.7 61023.7 61296.7 61996.4 63286.1 10287.9 10306.9 10309.1 10407.9 10410.3 13601.5 13631.2 13634.6 13660.0 13669.2 7184.3 7216.8 7250.9 7290.2 7323.5 6829.7 6836.4 6839.0 6846.1 6872.3 4405.5 4462.5 4480.9 4511.2 4515.4 1691.0 1754.3 1769.5 1826.0 1846.7 970.4 988.7 1004.0 1028.4 1032.0 14499.6 16297.9 16525.7 16732.5 17334.2 874.1 923.9 929.8 968.4 979.2 8995.4 9226.0 9259.3 9292.2 9423.8 526994.0 543305.0 558003.0 558016.0 560006.0 81795.6 82429.0 83799.6 84427.2 85339.0 1073.8 1100.2 1104.0 1129.6 1149.7 14952.9 15857.1 16248.3 16297.8 16489.7 37219.8 37539.8 38162.6 38463.8 38766.4 49852.0 51553.7 51806.5 52851.7 54226.0 9429.6 9764.3 9868.7 9874.9 9941.6 11613.9 11803.4 11813.6 11823.1 12536.6 14357.7 14578.3 14613.6 14777.4 14855.8 14598.4 14610.9 14772.3 15030.8 15382.9 15049.3 15273.5 15384.9 15721.1 15931.6 9856.3 9872.2 10058.4 10081.2 10085.1 14800.0 14808.8 15117.6 15205.3 15323.2 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5426.91 Median:6565.84 stddev:2832.55 (43.1%) stddev-sans-first:2823.77 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: Values: 1332.7 1745.6 1756.8 1792.8 1816.6 6720.3 7535.7 7647.4 7659.5 7667.4 7523.5 7717.8 7763.1 7791.9 7792.9 1975.6 2019.0 2020.3 2218.5 2261.8 2195.7 2231.5 2231.7 2232.7 2239.1 2169.8 2193.2 2222.8 2223.9 2224.6 2199.1 2232.0 2239.9 2270.1 2271.4 2215.4 2233.0 2256.0 2258.5 2260.6 7716.5 7802.3 7806.9 7812.4 7817.2 4505.5 4555.6 4571.5 4573.2 4590.3 2960.2 3062.4 3074.4 3091.0 3106.5 933.6 941.0 947.4 949.2 970.4 10725.1 10782.7 10785.1 10794.0 10837.3 4080.3 4116.9 4168.2 4188.1 4202.0 9083.3 9166.3 9175.7 9179.3 9186.4 4536.5 4549.9 4575.1 4587.8 4596.5 4085.4 4107.7 4117.3 4123.6 4126.0 3076.3 3110.1 3382.3 3592.3 3664.2 1132.9 1144.9 1145.6 1145.7 1153.7 1074.1 1075.6 1128.4 1251.6 1365.3 7344.2 7405.9 7422.1 7476.7 7485.8 1129.3 1133.2 1138.3 1147.1 1155.9 5816.5 5898.4 5901.3 5903.9 5905.2 9106.4 9215.4 9222.7 9315.9 9360.8 9185.9 9212.9 9236.7 9240.8 9243.4 7288.2 7317.9 7406.9 7483.4 7483.6 7430.1 7489.4 7503.5 7504.4 7505.6 8066.6 8140.1 8261.8 8368.0 8378.4 8476.3 8486.2 8505.2 8509.7 8638.5 6650.4 6769.4 6773.3 6799.6 6807.3 6506.6 6695.5 6935.5 7150.3 7345.5 6989.7 7003.2 7116.4 7223.5 7237.6 6900.9 6903.9 6990.0 7074.4 7093.8 7137.6 7148.3 7171.8 7183.0 7189.3 6463.2 6634.1 6643.7 6649.1 6657.9 6493.4 6521.1 6537.4 6563.1 6568.5 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,509 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5340.03 Median:6131.54 stddev:1619.46 (26.4%) stddev-sans-first:1579.56 07:13:07 INFO - 2015-12-17 07:13:07,510 DEBUG : BROWSER_OUTPUT: Values: 320.0 334.4 337.5 338.9 343.5 5866.2 6021.9 6074.7 6125.0 6138.1 5773.0 5954.4 5972.0 5990.0 6006.6 4657.4 4658.3 4659.9 4661.1 4666.1 4443.0 4555.8 4564.1 4572.2 4660.9 4476.3 4531.6 4541.3 4555.2 4564.2 4581.9 4589.4 4590.2 4614.7 4620.3 4021.2 4041.9 4066.8 4068.3 4071.7 5617.4 5735.4 5739.7 5804.2 5822.9 5310.1 5334.1 5340.3 5349.1 5354.8 6025.8 6414.6 6419.5 6424.5 6425.7 4254.7 4298.8 4368.2 4370.4 4383.0 6379.3 6465.9 6469.4 6471.1 6475.3 4425.6 4466.3 4469.4 4474.4 4478.8 4447.3 4478.4 4523.2 4523.8 4530.9 5221.8 5222.1 5231.6 5232.9 5236.6 6297.0 6305.0 6308.9 6309.8 6310.0 1577.0 1584.3 1586.2 1587.7 1589.3 1059.8 1067.1 1071.4 1074.9 1094.7 6172.7 6173.0 6175.7 6175.8 6182.3 6611.2 6613.0 6616.3 6620.4 6632.0 6030.3 6172.9 6174.0 6174.4 6181.8 3565.3 3596.3 3596.6 3599.9 3600.7 6705.1 6709.6 6709.9 6714.4 6719.0 6652.5 6721.9 6781.7 6789.8 6799.2 6737.1 6739.4 6744.6 6747.7 6757.4 6432.3 6598.5 6623.9 6646.3 6650.5 6401.8 6602.4 6603.2 6617.6 6635.0 6795.5 6797.9 6802.3 6803.4 6803.7 4429.3 4446.6 4525.2 4535.4 4557.0 6651.3 6687.9 6690.2 6697.8 6706.1 6496.1 6514.2 6519.2 6521.3 6522.1 6276.7 6477.3 6481.3 6489.8 6508.3 6390.8 6401.3 6402.6 6407.4 6409.2 6545.5 6549.1 6549.8 6554.2 6558.1 6233.3 6335.2 6375.4 6389.9 6392.3 07:13:07 INFO - 2015-12-17 07:13:07,511 DEBUG : BROWSER_OUTPUT: 07:13:07 INFO - 2015-12-17 07:13:07,511 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13695.27 Median:4423.16 stddev:15900.53 (359.5%) stddev-sans-first:15915.22 07:13:07 INFO - 2015-12-17 07:13:07,511 DEBUG : BROWSER_OUTPUT: Values: 708.5 712.9 729.9 743.4 826.8 13766.9 13927.8 13969.4 14027.1 14031.5 12783.2 13021.3 13109.5 13123.7 13635.3 824.7 837.8 839.9 839.9 841.2 822.6 826.5 831.4 831.9 832.8 869.3 876.1 879.0 879.4 880.3 873.7 876.6 877.2 877.5 878.4 635.1 638.3 638.4 638.5 639.5 11153.4 11283.5 11324.4 11427.9 11430.1 10720.0 10949.4 11020.4 11102.0 11136.1 9983.1 9992.4 10036.1 10134.2 10462.1 3455.4 3476.1 3527.0 3537.2 3602.9 42260.6 42952.0 43031.6 43058.8 45383.5 6899.3 9872.7 10908.0 10958.0 11426.7 18560.3 18723.3 18777.8 18780.3 18784.2 7555.7 7558.2 7595.7 7898.5 7933.9 4358.3 4403.2 4443.2 4455.7 4476.3 3145.1 3165.6 3171.3 3173.6 3175.8 510.6 534.2 555.0 591.3 602.3 507.2 529.6 541.5 590.9 597.3 8173.9 8358.5 8540.5 8590.7 8707.5 484.2 597.2 654.7 656.3 671.2 3990.4 4023.7 4036.0 4046.1 4062.9 59490.7 60287.7 60414.1 60514.1 60633.1 50646.7 52219.7 52421.7 52805.2 52982.5 42324.4 43361.8 46668.8 47107.5 47989.3 8817.8 9134.2 9171.0 9196.1 9207.1 35658.3 35759.3 35819.1 36685.8 36721.8 38507.8 42521.6 42574.8 45415.8 47209.8 10549.3 10666.6 10811.6 10834.3 11077.0 11782.5 11809.8 12528.1 12640.0 13069.3 10858.2 10952.6 11239.2 11393.9 11696.6 10937.3 11454.0 11570.3 11641.4 11761.2 11297.5 11446.5 11712.4 11941.1 12022.6 9817.9 9833.0 10035.1 10086.7 10123.8 9007.5 9384.6 9533.1 9930.2 10237.6 07:13:07 INFO - 2015-12-17 07:13:07,511 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:13:07 INFO - 2015-12-17 07:13:07,511 DEBUG : BROWSER_OUTPUT: 07:13:08 INFO - 2015-12-17 07:13:08,186 INFO : Browser exited with error code: 0 07:13:08 INFO - 2015-12-17 07:13:08,207 INFO : Completed test dromaeo_css (00:18:32) 07:13:08 INFO - 2015-12-17 07:13:08,207 INFO : Starting test kraken 07:13:08 INFO - 2015-12-17 07:13:08,207 DEBUG : operating with platform_type : linux_ 07:13:08 INFO - 2015-12-17 07:13:08,207 INFO : Initialising browser for kraken test... 07:13:08 INFO - 2015-12-17 07:13:08,214 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg6nvvT/profile http://localhost:46320/getInfo.html 07:13:12 INFO - 2015-12-17 07:13:12,047 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:13:12 INFO - 2015-12-17 07:13:12,047 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:13:12 INFO - 2015-12-17 07:13:12,047 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:13:12 INFO - 2015-12-17 07:13:12,047 DEBUG : BROWSER_OUTPUT: __metrics 07:13:12 INFO - 2015-12-17 07:13:12,128 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:13:12 INFO - 2015-12-17 07:13:12,171 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:13:13 INFO - 2015-12-17 07:13:13,382 INFO : Browser initialized. 07:13:13 INFO - 2015-12-17 07:13:13,383 INFO : Running cycle 1/1 for kraken test... 07:13:13 INFO - 2015-12-17 07:13:13,383 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpg6nvvT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:13:25 INFO - 2015-12-17 07:13:25,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 142942208 07:13:25 INFO - 2015-12-17 07:13:25,238 DEBUG : BROWSER_OUTPUT: 07:13:27 INFO - 2015-12-17 07:13:27,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46320/tests/kraken/driver.html?testName=audio-beat-detection) 07:13:28 INFO - 2015-12-17 07:13:28,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 177262592 07:13:28 INFO - 2015-12-17 07:13:28,307 DEBUG : BROWSER_OUTPUT: 07:13:30 INFO - 2015-12-17 07:13:30,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46320/tests/kraken/driver.html?testName=audio-dft) 07:13:31 INFO - 2015-12-17 07:13:31,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 168243200 07:13:31 INFO - 2015-12-17 07:13:31,457 DEBUG : BROWSER_OUTPUT: 07:13:34 INFO - 2015-12-17 07:13:34,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46320/tests/kraken/driver.html?testName=audio-fft) 07:13:34 INFO - 2015-12-17 07:13:34,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 152584192 07:13:34 INFO - 2015-12-17 07:13:34,922 DEBUG : BROWSER_OUTPUT: 07:13:36 INFO - 2015-12-17 07:13:36,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46320/tests/kraken/driver.html?testName=audio-oscillator) 07:13:37 INFO - 2015-12-17 07:13:37,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 154132480 07:13:37 INFO - 2015-12-17 07:13:37,492 DEBUG : BROWSER_OUTPUT: 07:13:39 INFO - 2015-12-17 07:13:39,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46320/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:13:40 INFO - 2015-12-17 07:13:40,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 157011968 07:13:40 INFO - 2015-12-17 07:13:40,267 DEBUG : BROWSER_OUTPUT: 07:13:43 INFO - 2015-12-17 07:13:43,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46320/tests/kraken/driver.html?testName=imaging-darkroom) 07:13:43 INFO - 2015-12-17 07:13:43,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 158519296 07:13:43 INFO - 2015-12-17 07:13:43,712 DEBUG : BROWSER_OUTPUT: 07:13:47 INFO - 2015-12-17 07:13:47,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46320/tests/kraken/driver.html?testName=imaging-desaturate) 07:13:47 INFO - 2015-12-17 07:13:47,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 157392896 07:13:47 INFO - 2015-12-17 07:13:47,648 DEBUG : BROWSER_OUTPUT: 07:13:50 INFO - 2015-12-17 07:13:50,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46320/tests/kraken/driver.html?testName=json-parse-financial) 07:13:50 INFO - 2015-12-17 07:13:50,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 156917760 07:13:51 INFO - 2015-12-17 07:13:50,999 DEBUG : BROWSER_OUTPUT: 07:13:52 INFO - 2015-12-17 07:13:52,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46320/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:13:53 INFO - 2015-12-17 07:13:53,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 167399424 07:13:53 INFO - 2015-12-17 07:13:53,128 DEBUG : BROWSER_OUTPUT: 07:13:54 INFO - 2015-12-17 07:13:54,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:13:55 INFO - 2015-12-17 07:13:55,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 165179392 07:13:55 INFO - 2015-12-17 07:13:55,531 DEBUG : BROWSER_OUTPUT: 07:13:57 INFO - 2015-12-17 07:13:57,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:13:58 INFO - 2015-12-17 07:13:58,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 175345664 07:13:58 INFO - 2015-12-17 07:13:58,136 DEBUG : BROWSER_OUTPUT: 07:14:00 INFO - 2015-12-17 07:14:00,591 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:14:01 INFO - 2015-12-17 07:14:01,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 184315904 07:14:01 INFO - 2015-12-17 07:14:01,172 DEBUG : BROWSER_OUTPUT: 07:14:03 INFO - 2015-12-17 07:14:03,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:14:04 INFO - 2015-12-17 07:14:04,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 180965376 07:14:04 INFO - 2015-12-17 07:14:04,326 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46320/tests/kraken/driver.html?testName=ai-astar) 07:14:06 INFO - 2015-12-17 07:14:06,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 238997504 07:14:06 INFO - 2015-12-17 07:14:06,267 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,267 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;110;112;111;100;112;111;111 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;123;148;163;124;146;154;126;160;123 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;160;160;162;161;160;161;161;162 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;82;78;97;71;75;72;103;94;71 07:14:06 INFO - 2015-12-17 07:14:06,268 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;142;100;95;94;141;93;94;140 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;110;109;109;109 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;145;147;146;145;145;145 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;96;96;96;96 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;60;58;59;59;60;67;56;55 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;68;69;68;69;69;68;68 07:14:06 INFO - 2015-12-17 07:14:06,269 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;94;84;84;86;85;86;86;86 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;122;138;138;116;124;118;117;115;125 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;156;152;156;153;141;151;149;150;141 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;70;66;67;67;68;66;67;66;70 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,912 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365246262__endTimestamp 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,270 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 110.0 112.0 111.0 100.0 112.0 111.0 111.0 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.20 Median:151.00 stddev:16.44 (10.9%) stddev-sans-first:16.77 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: Values: 155.0 123.0 148.0 163.0 124.0 146.0 154.0 126.0 160.0 123.0 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 160.0 160.0 162.0 161.0 160.0 161.0 161.0 162.0 07:14:06 INFO - 2015-12-17 07:14:06,271 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:12.28 (16.0%) stddev-sans-first:12.32 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: Values: 70.0 82.0 78.0 97.0 71.0 75.0 72.0 103.0 94.0 71.0 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.70 Median:94.00 stddev:22.38 (23.8%) stddev-sans-first:23.09 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 142.0 100.0 95.0 94.0 141.0 93.0 94.0 140.0 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 07:14:06 INFO - 2015-12-17 07:14:06,272 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 145.0 147.0 146.0 145.0 145.0 145.0 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:3.20 (5.3%) stddev-sans-first:3.39 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 60.0 58.0 59.0 59.0 60.0 67.0 56.0 55.0 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 69.0 68.0 69.0 69.0 68.0 68.0 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:3.00 (3.5%) stddev-sans-first:3.10 07:14:06 INFO - 2015-12-17 07:14:06,273 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 94.0 84.0 84.0 86.0 85.0 86.0 86.0 86.0 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.50 stddev:8.45 (6.8%) stddev-sans-first:8.85 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: Values: 128.0 122.0 138.0 138.0 116.0 124.0 118.0 117.0 115.0 125.0 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.50 stddev:5.69 (3.8%) stddev-sans-first:5.58 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: Values: 143.0 156.0 152.0 156.0 153.0 141.0 151.0 149.0 150.0 141.0 07:14:06 INFO - 2015-12-17 07:14:06,274 DEBUG : BROWSER_OUTPUT: 07:14:06 INFO - 2015-12-17 07:14:06,275 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:1.51 (2.2%) stddev-sans-first:1.59 07:14:06 INFO - 2015-12-17 07:14:06,275 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 66.0 67.0 67.0 68.0 66.0 67.0 66.0 70.0 07:14:06 INFO - 2015-12-17 07:14:06,275 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:06 INFO - 2015-12-17 07:14:06,275 DEBUG : BROWSER_OUTPUT: 07:14:07 INFO - 2015-12-17 07:14:07,062 INFO : Browser exited with error code: 0 07:14:07 INFO - 2015-12-17 07:14:07,113 INFO : Completed test kraken (00:00:58) 07:14:07 INFO - 2015-12-17 07:14:07,113 INFO : Starting test v8_7 07:14:07 INFO - 2015-12-17 07:14:07,113 DEBUG : operating with platform_type : linux_ 07:14:07 INFO - 2015-12-17 07:14:07,114 INFO : Initialising browser for v8_7 test... 07:14:07 INFO - 2015-12-17 07:14:07,120 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJutMb/profile http://localhost:46320/getInfo.html 07:14:10 INFO - 2015-12-17 07:14:10,936 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:14:10 INFO - 2015-12-17 07:14:10,936 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:14:10 INFO - 2015-12-17 07:14:10,936 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:14:10 INFO - 2015-12-17 07:14:10,936 DEBUG : BROWSER_OUTPUT: __metrics 07:14:11 INFO - 2015-12-17 07:14:11,024 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:14:11 INFO - 2015-12-17 07:14:11,080 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:14:12 INFO - 2015-12-17 07:14:12,289 INFO : Browser initialized. 07:14:12 INFO - 2015-12-17 07:14:12,289 INFO : Running cycle 1/1 for v8_7 test... 07:14:12 INFO - 2015-12-17 07:14:12,290 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwJutMb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:14:24 INFO - 2015-12-17 07:14:24,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 142413824 07:14:24 INFO - 2015-12-17 07:14:24,122 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46320/tests/v8_7/run.html (next: http://localhost:46320/tests/v8_7/run.html) 07:14:45 INFO - 2015-12-17 07:14:45,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 624009216 07:14:45 INFO - 2015-12-17 07:14:45,832 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,833 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:14:45 INFO - 2015-12-17 07:14:45,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:14:45 INFO - 2015-12-17 07:14:45,833 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:14:45 INFO - 2015-12-17 07:14:45,833 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |0;Richards;167.897918065816 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.64365214110546 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.326369282891 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1986.111111111111 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 07:14:45 INFO - 2015-12-17 07:14:45,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;12195.121951219513 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: |8;Splay;674.5252128356254 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: __startTimestamp1450365285832__endTimestamp 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,835 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:14:45 INFO - 2015-12-17 07:14:45,836 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:14:45 INFO - 2015-12-17 07:14:45,836 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,836 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.90 Median:167.90 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 167.9 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.64 Median:188.64 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 188.6 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 282.3 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 5148.7 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1986.11 Median:1986.11 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 1986.1 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,837 DEBUG : BROWSER_OUTPUT: Values: 789.9 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12195.12 Median:12195.12 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: Values: 12195.1 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: Values: 25974.4 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:674.53 Median:674.53 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: Values: 674.5 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: 07:14:45 INFO - 2015-12-17 07:14:45,838 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 07:14:45 INFO - 2015-12-17 07:14:45,839 DEBUG : BROWSER_OUTPUT: Values: 4840.6 07:14:45 INFO - 2015-12-17 07:14:45,839 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:14:45 INFO - 2015-12-17 07:14:45,839 DEBUG : BROWSER_OUTPUT: 07:14:46 INFO - 2015-12-17 07:14:46,670 INFO : Browser exited with error code: 0 07:14:46 INFO - 2015-12-17 07:14:46,689 INFO : Completed test v8_7 (00:00:39) 07:14:46 INFO - 2015-12-17 07:14:46,781 INFO : Completed test suite (00:20:11) 07:14:46 INFO - 2015-12-17 07:14:46,782 DEBUG : Working with test: dromaeo_css 07:14:46 INFO - 2015-12-17 07:14:46,782 DEBUG : Generating results file: dromaeo_css 07:14:46 INFO - 2015-12-17 07:14:46,783 DEBUG : Working with test: kraken 07:14:46 INFO - 2015-12-17 07:14:46,783 DEBUG : Generating results file: kraken 07:14:46 INFO - 2015-12-17 07:14:46,783 INFO : javascript benchmark 07:14:46 INFO - 2015-12-17 07:14:46,783 DEBUG : Working with test: v8_7 07:14:46 INFO - 2015-12-17 07:14:46,784 DEBUG : Generating results file: v8_7 07:14:46 INFO - 2015-12-17 07:14:46,784 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - 2015-12-17 07:14:46,845 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:14:46 INFO - 2015-12-17 07:14:46,845 DEBUG : process_Request line: dromaeo_css 6961.95 graph.html#tests=[[72,1,35]] 07:14:46 INFO - 2015-12-17 07:14:46,845 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - 2015-12-17 07:14:46,877 DEBUG : process_Request line: kraken 1507.40 graph.html#tests=[[232,1,35]] 07:14:46 INFO - 2015-12-17 07:14:46,877 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:14:46 INFO - 2015-12-17 07:14:46,921 DEBUG : process_Request line: v8_7 19591.59 graph.html#tests=[[230,1,35]] 07:14:46 INFO - 2015-12-17 07:14:46,922 INFO : javascript benchmark 07:14:46 INFO - 2015-12-17 07:14:46,926 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3101.0851798719377, 3142.135912624027, 3183.029176101288, 3184.4586420308547, 3193.377291428171, 5095.0, 5232.3459567554055, 5339.626226164165, 5342.439043900393, 5404.405515393303, 5180.948190518094, 5235.712035838027, 5235.816746413867, 5289.867753306169, 5304.071787437202, 4787.425508938933, 4806.255030470283, 4822.252550854623, 4834.202356611155, 4860.4896485869, 4960.801567937278, 4967.453580106186, 4974.8258810941625, 4980.750962451881, 5014.323066386028, 4705.600023997964, 4806.687565308243, 4811.9037619247765, 4903.436104847952, 4925.901481970341, 4879.8780030499165, 4884.047610715912, 4917.0, 4931.679440836334, 4936.90126197474, 4835.854924352275, 4875.756212189412, 4876.756162191876, 4883.536064073907, 4916.877078073041, 5062.898742025176, 5085.669431486942, 5203.765830537635, 5205.505476979681, 5207.583393328562, 5768.596198266123, 5774.047282198432, 5775.133729940542, 5782.3350314713925, 5790.7394167262155, 5787.074068149118, 5807.332156801937, 5812.302523697141, 5812.476877081083, 5812.709364531756, 5253.527182553588, 5326.92009619856, 5336.946630533723, 5338.386085600167, 5392.352917649829, 5808.07070868659, 5909.202257695242, 5910.7931222407005, 5922.526197904157, 5967.850803729942, 5735.369109397963, 5737.799177028784, 5749.453801888814, 5749.913751293734, 5751.4536119068625, 5486.91769623456, 5528.308961379827, 5569.19246709233, 5698.6580805151825, 5805.274340707411, 5697.0599851024945, 5797.188393624896, 5801.12983052537, 5808.854778630483, 5810.535157187415, 5791.189233507313, 5791.652500849962, 5792.0, 5793.362730099686, 5797.652140871477, 4339.63113135387, 4400.669949753717, 4408.713433626804, 4463.196624607602, 4491.483479399845, 3984.7011474139554, 4001.5398229203433, 4002.579729128458, 4034.8789536313957, 4045.6561192298986, 5470.753816078286, 5483.4516548344845, 5483.890322193533, 5489.752961116759, 5529.281193444826, 5503.257060296889, 5533.418991005887, 5588.050031494656, 5603.719814009283, 5845.064789633723, 5244.580433565306, 5347.0, 5352.330958630171, 5357.0, 5362.597805164551, 4995.350604421475, 5025.070361983045, 5025.346704928409, 5027.4218464877, 5071.366079240095, 5625.578081643893, 5724.971375143097, 5839.386864379264, 5853.795117170878, 5859.853503662443, 5734.713264336683, 5810.389909059488, 5889.440503152194, 5892.381299963442, 5920.171176035445, 5856.385079566584, 5859.326177489473, 5862.0, 5864.824055278348, 5865.706714664335, 5513.062779327604, 5620.353659329229, 5648.943510564842, 5700.25896633435, 5712.171735098304, 5688.431156884279, 5690.459406356389, 5717.056685646988, 5727.513161381329, 5729.656220626775, 5523.585731070106, 5560.221568980265, 5602.579806514446, 5608.747606357805, 5609.859753506195, 5680.886382272414, 5709.8287051388525, 5713.371529131875, 5716.399778023248, 5720.342160651412, 5346.572274218131, 5600.915986260128, 5602.13166959122, 5604.551635869039, 5606.074997625346, 5544.0, 5560.0, 5569.331680198402, 5628.74670639814, 5676.063449530781, 5547.583931205095, 5548.805791797429, 5553.333599968029, 5554.555635549065, 5598.356189038313], "unit": "score", "name": "dojo.html", "value": 5287.815816582833}, {"lowerIsBetter": false, "replicates": [562.2100948167825, 588.493895250085, 596.4572239262272, 597.7818096394815, 597.8744463662631, 29542.852285738594, 37382.252354952885, 37854.621453785454, 37886.43170352447, 37925.43111853321, 41773.16453670932, 42283.15433691324, 42357.78821105898, 42427.363589546105, 42508.57491425085, 7551.962240188791, 7661.157272699998, 8690.826183476342, 8846.071162527938, 8858.0, 10353.327033742782, 10596.099331556788, 10606.15150787935, 10607.575696972111, 10611.84082238767, 10317.380957142557, 10429.73925651861, 10437.582496700123, 10440.060394564487, 10440.112590429822, 7768.611569421506, 7900.446968712193, 7902.881456778125, 10307.742306442324, 10490.265681402228, 10019.298649094566, 10151.340162889463, 10153.136983356424, 10156.035176658206, 10163.59345626174, 39025.0, 39501.60498395037, 39533.60466395357, 39547.20905581872, 39566.406503902464, 3184.8248346340943, 3209.8555564999633, 3235.9191020224685, 3289.3256882339065, 3615.963840361589, 29685.554716679268, 29959.0, 30121.700317327482, 30576.08271751851, 31055.0, 3909.706771992112, 3917.2948869203533, 3947.605239476058, 3983.601639836022, 4049.2913740095364, 253927.0, 256823.0, 257001.0, 257100.0, 258217.0, 54779.0, 55158.0, 55176.72411637916, 55185.448145518836, 55193.44806551963, 56620.71689641608, 57817.4218257812, 64412.677936610955, 65426.0, 65687.34312656813, 13124.409401576951, 13132.934335328262, 13227.867721322857, 13238.338083095807, 13238.404271807793, 9623.711288661352, 9626.326157169071, 9626.855597166048, 9631.181349585364, 9642.180414664692, 18567.35014274521, 18718.625627487374, 18733.718994215098, 18794.248230070916, 18824.717629235573, 7056.259092795285, 7358.632068396559, 7358.718797172894, 7448.813779655552, 7456.701731930662, 939.3283802081545, 958.3195930889008, 1009.2531526670358, 1065.898739619735, 1095.3865835132192, 22249.11003559872, 22440.0, 22480.0, 23440.64839027416, 23569.410764730677, 1094.316052467208, 1120.3669926491507, 1132.8470656461436, 1136.4772204785727, 1166.6033548593518, 13959.581212563638, 14058.71882562343, 14196.0, 14255.429782808778, 14276.85723142776, 294184.0, 296674.0, 297147.0, 297220.0, 297410.0, 50730.74634626803, 50767.0, 50898.74550627297, 51046.48953510417, 51197.488025120016, 1340.544214966916, 1354.3228385807097, 1361.673198432389, 1366.5695305978586, 1373.8420081690733, 25953.480930381666, 27113.373197608205, 27177.59233611458, 27187.72812271852, 27760.0, 42515.7874210627, 43143.78428107965, 47424.0, 47532.0, 47825.521744782105, 413676.0, 418390.0, 420780.0, 420849.0, 421088.0, 30864.228394289425, 31337.373252534366, 31344.843275784388, 31356.372872542877, 31384.372312553165, 42675.0, 43055.354169686856, 43095.35356969585, 43313.0, 44072.11855762931, 36283.24331886162, 36661.45007824938, 36776.44835327419, 37154.628453715115, 37779.244415110996, 35310.0, 36010.0, 36517.08707282233, 36849.447258291686, 37612.2477550442, 26435.867820660773, 26440.338991525365, 26466.735332646425, 26484.337891552866, 26648.8667556661, 27570.0, 27918.581221281293, 29958.450476451642, 32086.83956580202, 32315.838420807744, 24362.147324843547, 24432.267031989068, 24497.75502245026, 24681.876590616932, 24800.379990500383], "unit": "score", "name": "ext.html", "value": 18236.71943153446}, {"lowerIsBetter": false, "replicates": [345.20086000907895, 345.6750654384878, 346.9107004007417, 347.3365871186035, 347.4492928707997, 13729.107608005497, 14041.859581404184, 16032.198390080493, 16486.917565412172, 17148.742768858476, 15649.92175039126, 15664.0, 16288.10415427151, 16306.266218020188, 16308.347666093372, 5023.623228257877, 5348.705821179834, 5354.437784032679, 5356.625036247464, 5357.357117145929, 3927.17529318842, 4041.0301527633305, 5272.340957380327, 5783.161441590967, 5957.434043765857, 5854.619449735775, 5884.440978107094, 5895.145203945425, 5900.144479050535, 5900.852478688024, 5766.452187042224, 5858.882822343529, 5898.528117750569, 5904.055351143839, 5905.763769449239, 5179.689218646856, 5205.479452054802, 5218.921716174261, 5233.581313494911, 5234.476552344773, 12307.384630768514, 12675.936620316932, 12686.55597054108, 12691.365431728376, 20337.694934575993, 2069.1309649947057, 2086.540960988595, 2172.8044475997235, 2388.8805559721945, 2518.508890766301, 9497.097775711365, 9513.524323783784, 9622.807543849154, 9703.708888733348, 9851.408915465096, 1843.271907596492, 1857.8978156201404, 1860.944171674852, 1870.326682394337, 1874.3627166763365, 60169.6991515044, 61023.69488152575, 61296.693516532134, 61996.38003619996, 63286.0507092394, 10287.897121028844, 10306.896931030744, 10309.123724483354, 10407.94796026015, 10410.323328983592, 13601.455941762219, 13631.182129072287, 13634.590962271148, 13660.043796934318, 13669.179849209078, 7184.281571842774, 7216.819579510554, 7250.927490725026, 7290.161631412349, 7323.523970941872, 6829.69266383004, 6836.418904393182, 6839.0, 6846.075779769767, 6872.278410766898, 4405.515393306734, 4462.464504259509, 4480.887977800581, 4511.187986162522, 4515.412996310459, 1690.9746353804703, 1754.2632094520332, 1769.469159252245, 1825.954351141232, 1846.6583682018602, 970.3547141151197, 988.6539711101201, 1003.9648612298535, 1028.3521381529588, 1031.9638812641522, 14499.637509062359, 16297.918510407371, 16525.6694866102, 16732.498025059023, 17334.219960101826, 874.1084094223983, 923.9029901860208, 929.8279818233649, 968.4286271099944, 979.2313034268066, 8995.415298005608, 9226.0, 9259.30555208362, 9292.229258772464, 9423.811523769486, 526994.0, 543305.0, 558003.0, 558016.0, 560006.0, 81795.59102204451, 82429.0, 83799.5810020946, 84427.15572844316, 85339.0, 1073.8228192348174, 1100.1913593508764, 1103.9503222355013, 1129.5989923577013, 1149.6953307373553, 14952.925235373754, 15857.127857967922, 16248.26882790301, 16297.837021629632, 16489.67020659556, 37219.8139009314, 37539.81230093941, 38162.61837381591, 38463.807680961414, 38766.4185037219, 49852.0, 51553.742231288605, 51806.48193518016, 52851.68447410615, 54226.0, 9429.575669095044, 9764.316497845082, 9868.703938881845, 9874.92626548433, 9941.552630131517, 11613.883861161617, 11803.409829508319, 11813.645590632295, 11823.11326650522, 12536.623901282976, 14357.712845742817, 14578.343974521384, 14613.561593152222, 14777.408903643734, 14855.777163342775, 14598.416063357772, 14610.926945365205, 14772.261386930826, 15030.795504901644, 15382.923085384502, 15049.322780475124, 15273.465428709942, 15384.923075384551, 15721.135337556545, 15931.60170995688, 9856.31005829585, 9872.160866326443, 10058.446785426871, 10081.243906707174, 10085.092341689284, 14800.0, 14808.7778683322, 15117.622059448602, 15205.31576079057, 15323.157226352658], "unit": "score", "name": "jquery.html", "value": 8818.932073136299}, {"lowerIsBetter": false, "replicates": [1332.746778112158, 1745.5636090977255, 1756.8331008554183, 1792.8027916929143, 1816.5549440387103, 6720.2943690912425, 7535.736249231278, 7647.426443016768, 7659.540427574349, 7667.3866090712745, 7523.510971786844, 7717.807054823632, 7763.107242667095, 7791.883121753164, 7792.883106753403, 1975.6443840108846, 2019.0207749241606, 2020.3130935481934, 2218.5119273759747, 2261.796438320551, 2195.6596727507263, 2231.4532939429782, 2231.654093615492, 2232.6651002349695, 2239.0595949701083, 2169.8155656769195, 2193.1994821889975, 2222.7666095060026, 2223.8776867272295, 2224.5662095891307, 2199.0763879170786, 2232.0402227042364, 2239.9440013999697, 2270.1373478078226, 2271.3867255840914, 2215.423989762657, 2232.9888350558304, 2255.954880902389, 2258.525709600986, 2260.626996545568, 7716.498427602244, 7802.297793198582, 7806.921930780733, 7812.414068944795, 7817.179196184433, 4505.459344878603, 4555.612772914306, 4571.474280457756, 4573.176828170928, 4590.311453282001, 2960.156355438711, 3062.4028314478687, 3074.3851229754137, 3091.0, 3106.5340198970334, 933.6498812945146, 941.0495399646406, 947.3794664494767, 949.1979277510493, 970.403202030753, 10725.088367488774, 10782.676519704342, 10785.13718902486, 10794.0, 10837.295575787548, 4080.2655522006326, 4116.938245926313, 4168.187203495289, 4188.099558594917, 4202.03353228753, 9083.318751093695, 9166.312526560534, 9175.678851240307, 9179.311551633655, 9186.356955013218, 4536.500984891659, 4549.931751023737, 4575.130725162275, 4587.79354929029, 4596.47140578831, 4085.3667681509414, 4107.691923105779, 4117.300058989979, 4123.567025462284, 4126.0097576582, 3076.32320889404, 3110.0980715592223, 3382.30662714143, 3592.317459682652, 3664.230511592542, 1132.8867113288604, 1144.856892888389, 1145.604766355606, 1145.667756350649, 1153.7288737146764, 1074.119222237773, 1075.6020272499225, 1128.4245035032193, 1251.6432816647393, 1365.337811161586, 7344.192138864721, 7405.925940740523, 7422.072240969879, 7476.663550140257, 7485.7754267372065, 1129.265977114882, 1133.1614605192262, 1138.2698298586104, 1147.1052578988401, 1155.9190856640123, 5816.534677225812, 5898.351181370046, 5901.29184497863, 5903.911441328383, 5905.173275741399, 9106.362554621246, 9215.400998935182, 9222.723318300461, 9315.906840931639, 9360.812783744286, 9185.908140918638, 9212.907870921204, 9236.67671631503, 9240.815183696423, 9243.445393276425, 7288.198298187195, 7317.938898859636, 7406.925930740624, 7483.438742094474, 7483.6258187090425, 7430.145533263744, 7489.363404110493, 7503.474756766974, 7504.362129219077, 7505.624718763931, 8066.556339401389, 8140.104588495379, 8261.793455163428, 8368.0, 8378.413511054168, 8476.321894248322, 8486.236238738544, 8505.23452889243, 8509.74470765878, 8638.481691098554, 6650.401463868275, 6769.356911093439, 6773.322667733188, 6799.5920244785475, 6807.285235050446, 6506.642134682638, 6695.497837662292, 6935.479839011993, 7150.320719531636, 7345.522541034816, 6989.650517474208, 7003.159620845531, 7116.43068554504, 7223.458240631869, 7237.63811809418, 6900.861982760216, 6903.89644155328, 6989.965050174716, 7074.434045276263, 7093.82265443368, 7137.607431591312, 7148.320909513588, 7171.820704482429, 7182.96408517954, 7189.317014883578, 6463.224413070461, 6634.071230027704, 6643.667816609247, 6649.102371180023, 6657.900131497934, 6493.350664933469, 6521.087047813215, 6537.378948999837, 6563.146790917151, 6568.540202185801], "unit": "score", "name": "mootools.html", "value": 4448.810059903958}, {"lowerIsBetter": false, "replicates": [319.9712025917667, 334.35970117225514, 337.5106096160568, 338.8932486266826, 343.53108007569676, 5866.2080619116405, 6021.909671354933, 6074.665893375868, 6124.969375153124, 6138.109974053759, 5773.0, 5954.374790646984, 5972.0444728843395, 5990.041593345066, 6006.579539432241, 4657.394538709963, 4658.277966915117, 4659.906801863961, 4661.09108723799, 4666.136764698542, 4443.044745379742, 4555.792714930546, 4564.109998550284, 4572.245579479382, 4660.86017419478, 4476.261416866213, 4531.56950089741, 4541.296099104644, 4555.157295900269, 4564.201264778667, 4581.908361832761, 4589.35748995141, 4590.219662657356, 4614.653900957442, 4620.330052142437, 4021.155557332964, 4041.939370909439, 4066.837326506966, 4068.2677118118727, 4071.6742660587083, 5617.4382561743905, 5735.397783232742, 5739.684317362585, 5804.216430781833, 5822.912656310159, 5310.070737620901, 5334.146536554172, 5340.279062326575, 5349.063913815066, 5354.759035843357, 6025.78909738157, 6414.550981431302, 6419.51853610981, 6424.518161137933, 6425.742970281183, 4254.680898932593, 4298.78506074695, 4368.191884501346, 4370.38814565961, 4382.9838274393815, 6379.266384365765, 6465.903011454832, 6469.417752402259, 6471.061696054046, 6475.255345635218, 4425.557444255549, 4466.2630665940405, 4469.41897553316, 4474.418325617649, 4478.753668548261, 4447.3329000650165, 4478.350639157369, 4523.231050721385, 4523.751193684313, 4530.88672783183, 5221.791128354823, 5222.112240919053, 5231.581473482112, 5232.869178270574, 5236.607254455931, 6296.961001434712, 6305.0, 6308.905366419507, 6309.810705678837, 6310.0, 1576.9763453548205, 1584.3345794766226, 1586.2068965517242, 1587.6904003719394, 1589.3007076886133, 1059.7774467361787, 1067.0876400677464, 1071.3571856885962, 1074.854894589236, 1094.6934858239706, 6172.660503672341, 6172.969135154295, 6175.660338681416, 6175.84560385985, 6182.258129024456, 6611.20665520131, 6612.9749888766355, 6616.27221005689, 6620.3710647488415, 6632.0383544385795, 6030.33666296707, 6172.9074063889075, 6174.043023331391, 6174.44430001302, 6181.8454538636, 3565.2691198304287, 3596.2627661329366, 3596.5684117906017, 3599.94600080999, 3600.7299452541165, 6705.1283333166375, 6709.597424154566, 6709.865802683919, 6714.429273511806, 6718.966405167943, 6652.501062420241, 6721.93278067213, 6781.6609169541325, 6789.796306110825, 6799.184097908283, 6737.090492783412, 6739.427148692318, 6744.62904540255, 6747.730090796314, 6757.425618822455, 6432.2602900667025, 6598.538102332983, 6623.867522649423, 6646.268910419753, 6650.46796256308, 6401.775937842153, 6602.40578347951, 6603.174603174603, 6617.636030018395, 6635.0, 6795.490338224752, 6797.864042719217, 6802.285759995327, 6803.387695107464, 6803.659817009031, 4429.269170586946, 4446.577575130357, 4525.230710779241, 4535.387722657399, 4556.977215113903, 6651.26836048044, 6687.926742709776, 6690.1971763386755, 6697.832554186184, 6706.128203333536, 6496.058071579689, 6514.218293804774, 6519.152510173647, 6521.282658907421, 6522.05430212626, 6276.74893004293, 6477.287498375269, 6481.319461456479, 6489.805305840832, 6508.284088750328, 6390.7763228286785, 6401.29585745577, 6402.551821372459, 6407.391297826699, 6409.166808314889, 6545.5090868184125, 6549.148610680581, 6549.803505894831, 6554.2462616797775, 6558.147440832661, 6233.314335423009, 6335.239771227482, 6375.4262116409745, 6389.9361006389345, 6392.264889537577], "unit": "score", "name": "prototype.html", "value": 4810.636654261576}, {"lowerIsBetter": false, "replicates": [708.4898872811574, 712.8788106021975, 729.8941653460245, 743.4275607782005, 826.7974346285159, 13766.862331376684, 13927.791083133736, 13969.441222351094, 14027.088239264453, 14031.5088971886, 12783.169094008883, 13021.28382938938, 13109.541166059189, 13123.73752524949, 13635.250061246628, 824.7402068348481, 837.8324335132967, 839.9244068033876, 839.937004724645, 841.188253335531, 822.5722624235394, 826.4834478450969, 831.4221615976899, 831.9376046796484, 832.8375966686499, 869.3088994249555, 876.0669886570813, 879.0111124984393, 879.3712495565669, 880.2561835249204, 873.7422460374205, 876.6230520876021, 877.171073335698, 877.5085951866943, 878.376352789517, 635.1425575473074, 638.2819328255713, 638.4158494977137, 638.4732595608641, 639.5043841023198, 11153.442327883573, 11283.548658053667, 11324.433778311051, 11427.942860285728, 11430.085593152528, 10720.0, 10949.397783121925, 11020.44897755109, 11102.0, 11136.053435457996, 9983.101520863158, 9992.350497217658, 10036.14692751117, 10134.23993200513, 10462.110720588758, 3455.3780319542725, 3476.1309672581856, 3527.0476971217627, 3537.239493508908, 3602.9279414411826, 42260.57739422597, 42952.0, 43031.56968430307, 43058.784706076585, 45383.546164538595, 6899.323464398159, 9872.703818885446, 10908.018278354828, 10958.0, 11426.714332141597, 18560.25758969653, 18723.344682936033, 18777.81222187788, 18780.342688005854, 18784.154713037948, 7555.697772089165, 7558.206388329256, 7595.734149304748, 7898.486598371088, 7933.880991785128, 4358.3244597087505, 4403.163398954189, 4443.155800397914, 4455.688101832905, 4476.328550717419, 3145.072203699914, 3165.6201255849446, 3171.2864605463587, 3173.587433633613, 3175.7618178636694, 510.5660188839457, 534.1907010878522, 554.9583781216425, 591.2786400591272, 602.2682440834408, 507.18090284190765, 529.6001518853241, 541.4531323363352, 590.8788698316835, 597.2922087326446, 8173.877391839127, 8358.498490090615, 8540.53027083504, 8590.699325523577, 8707.47755134694, 484.20590232019515, 597.1513594881037, 654.7184710574498, 656.3305428462941, 671.1945665201778, 3990.4413382125945, 4023.6982226333143, 4036.0, 4046.069404037088, 4062.878113656595, 59490.70254648699, 60287.69856150779, 60414.09378859321, 60514.092288615706, 60633.09050364248, 50646.74676626593, 52219.73890130601, 52421.73789131106, 52805.2079218812, 52982.47017529853, 42324.36513452239, 43361.783191084476, 46668.76665616718, 47107.528924710314, 47989.28016079831, 8817.823643527221, 9134.184476268123, 9170.954145229498, 9196.114796466842, 9207.125323094295, 35658.28683426369, 35759.28481430305, 35819.10452238715, 36685.81657091698, 36721.81639091788, 38507.80746096364, 42521.57478425176, 42574.78712606417, 45415.77292113518, 47209.76395118002, 10549.314294570828, 10666.62666806689, 10811.6215932442, 10834.349939003685, 11077.0, 11782.469788859693, 11809.82285265739, 12528.123031387715, 12640.0, 13069.346532673138, 10858.185636077484, 10952.56189752401, 11239.213255072067, 11393.886061139283, 11696.649100526998, 10937.343759374464, 11454.0, 11570.305781653127, 11641.41792910368, 11761.176717629683, 11297.491612877277, 11446.484908179318, 11712.355820429959, 11941.104417168573, 12022.579209727617, 9817.852732209165, 9832.950835246063, 10035.14701250402, 10086.697399078039, 10123.79752404933, 9007.549622518978, 9384.57769400365, 9533.142017218484, 9930.205583553443, 10237.641682541076], "unit": "score", "name": "yui.html", "value": 6255.492004498735}], "name": "dromaeo_css", "value": 6961.949321751367}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 110.0, 112.0, 111.0, 100.0, 112.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [155.0, 123.0, 148.0, 163.0, 124.0, 146.0, 154.0, 126.0, 160.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 142.2}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [70.0, 82.0, 78.0, 97.0, 71.0, 75.0, 72.0, 103.0, 94.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 100.0, 95.0, 94.0, 141.0, 93.0, 94.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 58.0, 59.0, 59.0, 60.0, 67.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 94.0, 84.0, 84.0, 86.0, 85.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [128.0, 122.0, 138.0, 138.0, 116.0, 124.0, 118.0, 117.0, 115.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [143.0, 156.0, 152.0, 156.0, 153.0, 141.0, 151.0, 149.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 66.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1507.4000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.897918065816], "unit": "score", "name": "Richards", "value": 210.25871200000006}, {"lowerIsBetter": false, "replicates": [188.64365214110546], "unit": "score", "name": "DeltaBlue", "value": 350.49151800000004}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1986.111111111111], "unit": "score", "name": "RayTrace", "value": 372.5818741258742}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12195.121951219513], "unit": "score", "name": "Boyer", "value": 54.64996600000001}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [674.5252128356254], "unit": "score", "name": "Splay", "value": 120.81238543689324}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19591.58522456925}]} 07:14:46 INFO - RETURN: dromaeo_css: 6961.95 07:14:46 INFO - RETURN: kraken: 1507.40 07:14:46 INFO - RETURN: v8_7: 19591.59 07:14:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19591.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1507.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6961.95"}}} 07:14:47 INFO - Return code: 0 07:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:14:47 ERROR - # TBPL SUCCESS # 07:14:47 INFO - Running post-action listener: _resource_record_post_action 07:14:47 INFO - Running post-run listener: _resource_record_post_run 07:14:48 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505991168; Read time: 16; Write time: 363436 07:14:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 238391296; Read time: 0; Write time: 215800 07:14:48 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 266694656; Read time: 16; Write time: 147052 07:14:48 INFO - Running post-run listener: _upload_blobber_files 07:14:48 INFO - Blob upload gear active. 07:14:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:14:48 INFO - Copying logs to upload dir... 07:14:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.174414 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-17 07:14:47.551941) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:47.555536) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009201 build_url: 'https://queue.taskcluster.net/v1/task/ZhhW_rzzTaSHxJW7gTYKEw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:47.607146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:47.607514) ========= 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=c402a24d74c70935940d60dd000001de-1450361321.440923-970615544 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 07:14:47.657246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 07:14:47.657555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 07:14:47.657887) ========= ========= Total master_lag: 0.26 =========