builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1451972724.95 results: success (0) buildid: 20160104193126 builduid: a80fc6683ada4489aa29e867724a29fc revision: c8e48d86e37341c5b79ce7256a272edfbdf0043a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.949749) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.950258) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.950583) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006451 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.974548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.974881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.988495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:24.988812) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.037759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.038091) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.038518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.038829) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 21:45:25-- 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% 225M=0s 2016-01-04 21:45:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130376 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.185224) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.185648) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022245 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.246717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.247115) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8e48d86e37341c5b79ce7256a272edfbdf0043a --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c8e48d86e37341c5b79ce7256a272edfbdf0043a --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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 21:45:25,754 truncating revision to first 12 chars 2016-01-04 21:45:25,755 Setting DEBUG logging. 2016-01-04 21:45:25,755 attempt 1/10 2016-01-04 21:45:25,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c8e48d86e373?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 21:45:26,010 unpacking tar archive at: mozilla-inbound-c8e48d86e373/testing/mozharness/ program finished with exit code 0 elapsedTime=0.512968 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.775611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.776397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.787253) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.787602) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 21:45:25.788138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 21:45:25.788664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:45:26 INFO - MultiFileLogger online at 20160104 21:45:26 in /builds/slave/test-pgo 21:45:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:45:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:45:26 INFO - {'append_to_log': False, 21:45:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:45:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:45:26 INFO - 'branch': 'Mozilla-Inbound', 21:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:45:26 INFO - 'config_files': ('talos/linux_config.py',), 21:45:26 INFO - 'default_actions': ('clobber', 21:45:26 INFO - 'read-buildbot-config', 21:45:26 INFO - 'download-and-extract', 21:45:26 INFO - 'populate-webroot', 21:45:26 INFO - 'create-virtualenv', 21:45:26 INFO - 'install', 21:45:26 INFO - 'run-tests'), 21:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:45:26 INFO - 'download_minidump_stackwalk': True, 21:45:26 INFO - 'download_symbols': 'ondemand', 21:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:45:26 INFO - 'installer_path': 'installer.exe', 21:45:26 INFO - 'log_level': 'info', 21:45:26 INFO - 'log_name': 'talos', 21:45:26 INFO - 'log_to_console': True, 21:45:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:45:26 INFO - 'opt_config_files': (), 21:45:26 INFO - 'pip_index': False, 21:45:26 INFO - 'sps_profile': False, 21:45:26 INFO - 'sps_profile_interval': 0, 21:45:26 INFO - 'suite': 'dromaeojs-e10s', 21:45:26 INFO - 'system_bits': '32', 21:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:45:26 INFO - 'title': 'talos-linux64-ix-010', 21:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:45:26 INFO - 'use_talos_json': True, 21:45:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:45:26 INFO - 'work_dir': 'build'} 21:45:26 INFO - ##### 21:45:26 INFO - ##### Running clobber step. 21:45:26 INFO - ##### 21:45:26 INFO - Running pre-action listener: _resource_record_pre_action 21:45:26 INFO - Running main action method: clobber 21:45:26 INFO - rmtree: /builds/slave/test-pgo/build 21:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:45:26 INFO - Running post-action listener: _resource_record_post_action 21:45:26 INFO - ##### 21:45:26 INFO - ##### Running read-buildbot-config step. 21:45:26 INFO - ##### 21:45:26 INFO - Running pre-action listener: _resource_record_pre_action 21:45:26 INFO - Running main action method: read_buildbot_config 21:45:26 INFO - Using buildbot properties: 21:45:26 INFO - { 21:45:26 INFO - "project": "", 21:45:26 INFO - "product": "firefox", 21:45:26 INFO - "script_repo_revision": "production", 21:45:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 21:45:26 INFO - "repository": "", 21:45:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 21:45:26 INFO - "buildid": "20160104193126", 21:45:26 INFO - "pgo_build": "True", 21:45:26 INFO - "basedir": "/builds/slave/test-pgo", 21:45:26 INFO - "buildnumber": 584, 21:45:26 INFO - "slavename": "talos-linux64-ix-010", 21:45:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:45:26 INFO - "platform": "ubuntu64_hw", 21:45:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:45:26 INFO - "branch": "mozilla-inbound", 21:45:26 INFO - "repo_path": "integration/mozilla-inbound", 21:45:26 INFO - "revision": "c8e48d86e37341c5b79ce7256a272edfbdf0043a", 21:45:26 INFO - "stage_platform": "linux64-pgo", 21:45:26 INFO - "builduid": "a80fc6683ada4489aa29e867724a29fc", 21:45:26 INFO - "slavebuilddir": "test" 21:45:26 INFO - } 21:45:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:45:26 INFO - Running post-action listener: _resource_record_post_action 21:45:26 INFO - ##### 21:45:26 INFO - ##### Running download-and-extract step. 21:45:26 INFO - ##### 21:45:26 INFO - Running pre-action listener: _resource_record_pre_action 21:45:26 INFO - Running main action method: download_and_extract 21:45:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:26 INFO - https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/test_packages.json 21:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/test_packages.json 21:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:45:29 INFO - Downloaded 1302 bytes. 21:45:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:45:29 INFO - Using the following test package requirements: 21:45:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:45:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'jsshell-linux-x86_64.zip'], 21:45:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:45:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:45:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:45:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:45:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:45:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:45:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:29 INFO - https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:32 INFO - Downloaded 24051262 bytes. 21:45:32 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 21:45:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:32 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 21:45:33 INFO - Return code: 0 21:45:33 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 21:45:33 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')]} 21:45:33 INFO - https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:37 INFO - Downloaded 24051262 bytes. 21:45:37 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 21:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:45:37 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 21:45:39 INFO - Return code: 0 21:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:39 INFO - https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:40 INFO - Downloaded 11132285 bytes. 21:45:40 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 21:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:45:40 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 21:45:40 INFO - Return code: 0 21:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:40 INFO - https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:45:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YN3-UpiwSTmELrmyxIwN7g/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 21:45:42 INFO - Downloaded 54994523 bytes. 21:45:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:42 INFO - mkdir: /builds/slave/test-pgo/properties 21:45:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:45:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:45:42 INFO - Contents: 21:45:42 INFO - build_url:https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:45:42 INFO - Running post-action listener: _resource_record_post_action 21:45:42 INFO - Running post-action listener: set_extra_try_arguments 21:45:42 INFO - ##### 21:45:42 INFO - ##### Running populate-webroot step. 21:45:42 INFO - ##### 21:45:42 INFO - Running pre-action listener: _resource_record_pre_action 21:45:42 INFO - Running main action method: populate_webroot 21:45:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:45:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:45:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:45:42 INFO - '--tppagecycles', 21:45:42 INFO - '7'], 21:45:42 INFO - 'tests': ['tsvgm']}}, 21:45:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:45:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:45:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:45:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:45:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'tests': ['damp', 'tps']}, 21:45:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['damp', 'tps']}, 21:45:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:45:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:45:42 INFO - 'other': {'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'other_l64': {'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'other_nol64': {'tests': ['a11yr', 21:45:42 INFO - 'ts_paint', 21:45:42 INFO - 'tpaint', 21:45:42 INFO - 'sessionrestore', 21:45:42 INFO - 'sessionrestore_no_auto_restore']}, 21:45:42 INFO - 'svgr': {'tests': ['tsvgx', 21:45:42 INFO - 'tsvgr_opacity', 21:45:42 INFO - 'tart', 21:45:42 INFO - 'tscrollx', 21:45:42 INFO - 'cart']}, 21:45:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['tsvgx', 21:45:42 INFO - 'tsvgr_opacity', 21:45:42 INFO - 'tart', 21:45:42 INFO - 'tscrollx', 21:45:42 INFO - 'cart']}, 21:45:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'tests': ['tp5o']}, 21:45:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'talos_options': ['--e10s'], 21:45:42 INFO - 'tests': ['tp5o']}, 21:45:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'talos_options': ['--xperf_path', 21:45:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:42 INFO - 'tests': ['tp5n']}, 21:45:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:42 INFO - 'talos_options': ['--e10s', 21:45:42 INFO - '--xperf_path', 21:45:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:42 INFO - 'tests': ['tp5n']}}, 21:45:42 INFO - 'talos.zip': {'path': '', 21:45:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:45:42 INFO - Running post-action listener: _resource_record_post_action 21:45:42 INFO - ##### 21:45:42 INFO - ##### Running create-virtualenv step. 21:45:42 INFO - ##### 21:45:42 INFO - Running pre-action listener: _resource_record_pre_action 21:45:42 INFO - Running main action method: create_virtualenv 21:45:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:45:42 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 21:45:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:45:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:45:42 INFO - Using real prefix '/usr' 21:45:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:45:43 INFO - Installing distribute.............................................................................................................................................................................................done. 21:45:45 INFO - Installing pip.................done. 21:45:45 INFO - Return code: 0 21:45:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:45 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:45 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 21:45:45 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 21:45:45 INFO - Using env: {'DISPLAY': ':0', 21:45:45 INFO - 'HOME': '/home/cltbld', 21:45:45 INFO - 'LANG': 'en_US.UTF-8', 21:45:45 INFO - 'LANGUAGE': 'en_US:en', 21:45:45 INFO - 'LOGNAME': 'cltbld', 21:45:45 INFO - 'MAIL': '/var/mail/cltbld', 21:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:45 INFO - 'MOZ_NO_REMOTE': '1', 21:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:45 INFO - 'NO_EM_RESTART': '1', 21:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:45 INFO - 'SHELL': '/bin/bash', 21:45:45 INFO - 'SHLVL': '1', 21:45:45 INFO - 'TERM': 'linux', 21:45:45 INFO - 'TMOUT': '86400', 21:45:45 INFO - 'USER': 'cltbld', 21:45:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:45 INFO - '_': '/tools/buildbot/bin/python'} 21:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:45 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 21:45:45 INFO - Cleaning up... 21:45:45 INFO - Return code: 0 21:45:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:45 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:45 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 21:45:45 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 21:45:45 INFO - Using env: {'DISPLAY': ':0', 21:45:45 INFO - 'HOME': '/home/cltbld', 21:45:45 INFO - 'LANG': 'en_US.UTF-8', 21:45:45 INFO - 'LANGUAGE': 'en_US:en', 21:45:45 INFO - 'LOGNAME': 'cltbld', 21:45:45 INFO - 'MAIL': '/var/mail/cltbld', 21:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:45 INFO - 'MOZ_NO_REMOTE': '1', 21:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:45 INFO - 'NO_EM_RESTART': '1', 21:45:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:45 INFO - 'SHELL': '/bin/bash', 21:45:45 INFO - 'SHLVL': '1', 21:45:45 INFO - 'TERM': 'linux', 21:45:45 INFO - 'TMOUT': '86400', 21:45:45 INFO - 'USER': 'cltbld', 21:45:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:45 INFO - '_': '/tools/buildbot/bin/python'} 21:45:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:45 INFO - Downloading/unpacking psutil>=0.7.1 21:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:45:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:45:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:47 INFO - Installing collected packages: psutil 21:45:47 INFO - Running setup.py install for psutil 21:45:47 INFO - building 'psutil._psutil_linux' extension 21:45:47 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 21:45:47 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 21:45:47 INFO - building 'psutil._psutil_posix' extension 21:45:47 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 21:45:47 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 21:45:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:47 INFO - Successfully installed psutil 21:45:47 INFO - Cleaning up... 21:45:48 INFO - Return code: 0 21:45:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:45:48 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')]} 21:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:48 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')]} 21:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:48 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:48 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 21:45:48 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 21:45:48 INFO - Using env: {'DISPLAY': ':0', 21:45:48 INFO - 'HOME': '/home/cltbld', 21:45:48 INFO - 'LANG': 'en_US.UTF-8', 21:45:48 INFO - 'LANGUAGE': 'en_US:en', 21:45:48 INFO - 'LOGNAME': 'cltbld', 21:45:48 INFO - 'MAIL': '/var/mail/cltbld', 21:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:48 INFO - 'MOZ_NO_REMOTE': '1', 21:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:48 INFO - 'NO_EM_RESTART': '1', 21:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:48 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:48 INFO - 'SHELL': '/bin/bash', 21:45:48 INFO - 'SHLVL': '1', 21:45:48 INFO - 'TERM': 'linux', 21:45:48 INFO - 'TMOUT': '86400', 21:45:48 INFO - 'USER': 'cltbld', 21:45:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:48 INFO - '_': '/tools/buildbot/bin/python'} 21:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:45:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:45:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:45:49 INFO - Installing collected packages: mozsystemmonitor 21:45:49 INFO - Running setup.py install for mozsystemmonitor 21:45:50 INFO - Successfully installed mozsystemmonitor 21:45:50 INFO - Cleaning up... 21:45:50 INFO - Return code: 0 21:45:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:50 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:50 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 21:45:50 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 21:45:50 INFO - Using env: {'DISPLAY': ':0', 21:45:50 INFO - 'HOME': '/home/cltbld', 21:45:50 INFO - 'LANG': 'en_US.UTF-8', 21:45:50 INFO - 'LANGUAGE': 'en_US:en', 21:45:50 INFO - 'LOGNAME': 'cltbld', 21:45:50 INFO - 'MAIL': '/var/mail/cltbld', 21:45:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:50 INFO - 'MOZ_NO_REMOTE': '1', 21:45:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:50 INFO - 'NO_EM_RESTART': '1', 21:45:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:50 INFO - 'SHELL': '/bin/bash', 21:45:50 INFO - 'SHLVL': '1', 21:45:50 INFO - 'TERM': 'linux', 21:45:50 INFO - 'TMOUT': '86400', 21:45:50 INFO - 'USER': 'cltbld', 21:45:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:50 INFO - '_': '/tools/buildbot/bin/python'} 21:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 21:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:45:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:45:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:52 INFO - Downloading docopt-0.6.1.tar.gz 21:45:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:45:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 21:45:52 INFO - Running setup.py install for blobuploader 21:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:45:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:45:52 INFO - Running setup.py install for requests 21:45:53 INFO - Running setup.py install for docopt 21:45:53 INFO - Successfully installed blobuploader requests docopt 21:45:53 INFO - Cleaning up... 21:45:53 INFO - Return code: 0 21:45:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:45: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')]} 21:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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')]} 21:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:53 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 21:45:53 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 21:45:53 INFO - Using env: {'DISPLAY': ':0', 21:45:53 INFO - 'HOME': '/home/cltbld', 21:45:53 INFO - 'LANG': 'en_US.UTF-8', 21:45:53 INFO - 'LANGUAGE': 'en_US:en', 21:45:53 INFO - 'LOGNAME': 'cltbld', 21:45:53 INFO - 'MAIL': '/var/mail/cltbld', 21:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:53 INFO - 'MOZ_NO_REMOTE': '1', 21:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:53 INFO - 'NO_EM_RESTART': '1', 21:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:53 INFO - 'SHELL': '/bin/bash', 21:45:53 INFO - 'SHLVL': '1', 21:45:53 INFO - 'TERM': 'linux', 21:45:53 INFO - 'TMOUT': '86400', 21:45:53 INFO - 'USER': 'cltbld', 21:45:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:53 INFO - '_': '/tools/buildbot/bin/python'} 21:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:45:53 INFO - Running setup.py (path:/tmp/pip-jLAtIJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:45:53 INFO - Running setup.py (path:/tmp/pip-ceBx51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:45:53 INFO - Running setup.py (path:/tmp/pip-ctNFzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:45:53 INFO - Running setup.py (path:/tmp/pip-KiR61z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:45:53 INFO - Running setup.py (path:/tmp/pip-7pli2b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:45:53 INFO - Running setup.py (path:/tmp/pip-UNsrVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:45:53 INFO - Running setup.py (path:/tmp/pip-dDIQWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:45:54 INFO - Running setup.py (path:/tmp/pip-LS5D_r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:45:54 INFO - Running setup.py (path:/tmp/pip-iD302r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:45:54 INFO - Running setup.py (path:/tmp/pip-XZV971-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:45:54 INFO - Running setup.py (path:/tmp/pip-iOR46d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:45:54 INFO - Running setup.py (path:/tmp/pip-isG5Vd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:45:54 INFO - Running setup.py (path:/tmp/pip-Ez8H3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:45:54 INFO - Running setup.py (path:/tmp/pip-juMQ0S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:45:54 INFO - Running setup.py (path:/tmp/pip-eV7p5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:45:54 INFO - Running setup.py (path:/tmp/pip-VHi7n6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:45:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:45:54 INFO - Running setup.py (path:/tmp/pip-bQlcZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:45:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:45:54 INFO - Running setup.py install for manifestparser 21:45:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:45:54 INFO - Running setup.py install for mozcrash 21:45:54 INFO - Running setup.py install for mozdebug 21:45:55 INFO - Running setup.py install for mozdevice 21:45:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for mozfile 21:45:55 INFO - Running setup.py install for mozhttpd 21:45:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for mozinfo 21:45:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for mozInstall 21:45:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for mozleak 21:45:55 INFO - Running setup.py install for mozlog 21:45:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for moznetwork 21:45:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:45:55 INFO - Running setup.py install for mozprocess 21:45:56 INFO - Running setup.py install for mozprofile 21:45:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:45:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:45:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:45:56 INFO - Running setup.py install for mozrunner 21:45:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:45:56 INFO - Running setup.py install for mozscreenshot 21:45:56 INFO - Running setup.py install for moztest 21:45:56 INFO - Running setup.py install for mozversion 21:45:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:45:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:45:56 INFO - Cleaning up... 21:45:56 INFO - Return code: 0 21:45:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:56 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:45:56 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 21:45:56 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 21:45:56 INFO - Using env: {'DISPLAY': ':0', 21:45:56 INFO - 'HOME': '/home/cltbld', 21:45:56 INFO - 'LANG': 'en_US.UTF-8', 21:45:56 INFO - 'LANGUAGE': 'en_US:en', 21:45:56 INFO - 'LOGNAME': 'cltbld', 21:45:56 INFO - 'MAIL': '/var/mail/cltbld', 21:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:56 INFO - 'MOZ_NO_REMOTE': '1', 21:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:45:56 INFO - 'NO_EM_RESTART': '1', 21:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:45:56 INFO - 'PWD': '/builds/slave/test-pgo', 21:45:56 INFO - 'SHELL': '/bin/bash', 21:45:56 INFO - 'SHLVL': '1', 21:45:56 INFO - 'TERM': 'linux', 21:45:56 INFO - 'TMOUT': '86400', 21:45:56 INFO - 'USER': 'cltbld', 21:45:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:56 INFO - '_': '/tools/buildbot/bin/python'} 21:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:45:56 INFO - Running setup.py (path:/tmp/pip-4QFYj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:45:56 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)) 21:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:45:56 INFO - Running setup.py (path:/tmp/pip-XLWJSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:45:56 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)) 21:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:45:56 INFO - Running setup.py (path:/tmp/pip-rMV311-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:45:56 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)) 21:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:45:56 INFO - Running setup.py (path:/tmp/pip-w8POPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:45:57 INFO - Running setup.py (path:/tmp/pip-gWY4eD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:45:57 INFO - Running setup.py (path:/tmp/pip-qaExW3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:45:57 INFO - Running setup.py (path:/tmp/pip-JHN3V2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:45:57 INFO - Running setup.py (path:/tmp/pip-FkGCzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:45:57 INFO - Running setup.py (path:/tmp/pip-ja5kHU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:45:57 INFO - Running setup.py (path:/tmp/pip-9ZxL_R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:45:57 INFO - Running setup.py (path:/tmp/pip-KSPAAS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:45:57 INFO - Running setup.py (path:/tmp/pip-DRV1mO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:45:57 INFO - Running setup.py (path:/tmp/pip-KCZgtY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:45:57 INFO - Running setup.py (path:/tmp/pip-VzPRBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:45:57 INFO - Running setup.py (path:/tmp/pip-sVyOCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:45:57 INFO - Running setup.py (path:/tmp/pip-czZI3U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:45:57 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)) 21:45:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:45:57 INFO - Running setup.py (path:/tmp/pip-SVTGYh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:45:58 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)) 21:45:58 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)) 21:45:58 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)) 21:45:58 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)) 21:45:58 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)) 21:45:58 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)) 21:45:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:45:59 INFO - Downloading blessings-1.5.1.tar.gz 21:45:59 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 21:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:45:59 INFO - Installing collected packages: blessings 21:45:59 INFO - Running setup.py install for blessings 21:45:59 INFO - Successfully installed blessings 21:45:59 INFO - Cleaning up... 21:45:59 INFO - Return code: 0 21:45:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:45:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:00 INFO - Reading from file tmpfile_stdout 21:46:00 INFO - Current package versions: 21:46:00 INFO - argparse == 1.2.1 21:46:00 INFO - blessings == 1.5.1 21:46:00 INFO - blobuploader == 1.2.4 21:46:00 INFO - docopt == 0.6.1 21:46:00 INFO - manifestparser == 1.1 21:46:00 INFO - mozInstall == 1.12 21:46:00 INFO - mozcrash == 0.16 21:46:00 INFO - mozdebug == 0.1 21:46:00 INFO - mozdevice == 0.47 21:46:00 INFO - mozfile == 1.2 21:46:00 INFO - mozhttpd == 0.7 21:46:00 INFO - mozinfo == 0.9 21:46:00 INFO - mozleak == 0.1 21:46:00 INFO - mozlog == 3.1 21:46:00 INFO - moznetwork == 0.27 21:46:00 INFO - mozprocess == 0.22 21:46:00 INFO - mozprofile == 0.28 21:46:00 INFO - mozrunner == 6.11 21:46:00 INFO - mozscreenshot == 0.1 21:46:00 INFO - mozsystemmonitor == 0.0 21:46:00 INFO - moztest == 0.7 21:46:00 INFO - mozversion == 1.4 21:46:00 INFO - psutil == 3.1.1 21:46:00 INFO - requests == 1.2.3 21:46:00 INFO - wsgiref == 0.1.2 21:46:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:46:00 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')]} 21:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:00 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')]} 21:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:00 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:46:00 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 21:46:00 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 21:46:00 INFO - Using env: {'DISPLAY': ':0', 21:46:00 INFO - 'HOME': '/home/cltbld', 21:46:00 INFO - 'LANG': 'en_US.UTF-8', 21:46:00 INFO - 'LANGUAGE': 'en_US:en', 21:46:00 INFO - 'LOGNAME': 'cltbld', 21:46:00 INFO - 'MAIL': '/var/mail/cltbld', 21:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:00 INFO - 'MOZ_NO_REMOTE': '1', 21:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:00 INFO - 'NO_EM_RESTART': '1', 21:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:00 INFO - 'SHELL': '/bin/bash', 21:46:00 INFO - 'SHLVL': '1', 21:46:00 INFO - 'TERM': 'linux', 21:46:00 INFO - 'TMOUT': '86400', 21:46:00 INFO - 'USER': 'cltbld', 21:46:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:00 INFO - '_': '/tools/buildbot/bin/python'} 21:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:46:00 INFO - Cleaning up... 21:46:00 INFO - Return code: 0 21:46:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:46:00 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')]} 21:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:00 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')]} 21:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:00 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:46:00 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 21:46:00 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 21:46:00 INFO - Using env: {'DISPLAY': ':0', 21:46:00 INFO - 'HOME': '/home/cltbld', 21:46:00 INFO - 'LANG': 'en_US.UTF-8', 21:46:00 INFO - 'LANGUAGE': 'en_US:en', 21:46:00 INFO - 'LOGNAME': 'cltbld', 21:46:00 INFO - 'MAIL': '/var/mail/cltbld', 21:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:00 INFO - 'MOZ_NO_REMOTE': '1', 21:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:00 INFO - 'NO_EM_RESTART': '1', 21:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:00 INFO - 'SHELL': '/bin/bash', 21:46:00 INFO - 'SHLVL': '1', 21:46:00 INFO - 'TERM': 'linux', 21:46:00 INFO - 'TMOUT': '86400', 21:46:00 INFO - 'USER': 'cltbld', 21:46:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:00 INFO - '_': '/tools/buildbot/bin/python'} 21:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:00 INFO - Downloading/unpacking jsonschema 21:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:46:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:02 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 21:46:02 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:46:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:02 INFO - warning: no files found matching '*.txt' 21:46:02 INFO - no previously-included directories found matching 'build' 21:46:02 INFO - no previously-included directories found matching 'dist' 21:46:02 INFO - no previously-included directories found matching '.git*' 21:46:02 INFO - Installing collected packages: jsonschema, functools32 21:46:02 INFO - Running setup.py install for functools32 21:46:02 INFO - warning: no files found matching '*.txt' 21:46:02 INFO - no previously-included directories found matching 'build' 21:46:02 INFO - no previously-included directories found matching 'dist' 21:46:02 INFO - no previously-included directories found matching '.git*' 21:46:02 INFO - Successfully installed jsonschema functools32 21:46:02 INFO - Cleaning up... 21:46:02 INFO - Return code: 0 21:46:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:46:02 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')]} 21:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:02 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')]} 21:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:02 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 0x7f2a0aa6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13dd360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, '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': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', '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 21:46:02 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 21:46:02 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 21:46:02 INFO - Using env: {'DISPLAY': ':0', 21:46:02 INFO - 'HOME': '/home/cltbld', 21:46:02 INFO - 'LANG': 'en_US.UTF-8', 21:46:02 INFO - 'LANGUAGE': 'en_US:en', 21:46:02 INFO - 'LOGNAME': 'cltbld', 21:46:02 INFO - 'MAIL': '/var/mail/cltbld', 21:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:02 INFO - 'MOZ_NO_REMOTE': '1', 21:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:02 INFO - 'NO_EM_RESTART': '1', 21:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:02 INFO - 'SHELL': '/bin/bash', 21:46:02 INFO - 'SHLVL': '1', 21:46:02 INFO - 'TERM': 'linux', 21:46:02 INFO - 'TMOUT': '86400', 21:46:02 INFO - 'USER': 'cltbld', 21:46:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:02 INFO - '_': '/tools/buildbot/bin/python'} 21:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:02 INFO - Downloading/unpacking flake8 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:02 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 21:46:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:04 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 21:46:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:04 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 21:46:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:04 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 21:46:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:46:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:05 INFO - no previously-included directories found matching 'docs/_build' 21:46:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:05 INFO - Running setup.py install for pep8 21:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:05 INFO - no previously-included directories found matching 'docs/_build' 21:46:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:46:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:05 INFO - Cleaning up... 21:46:05 INFO - Return code: 0 21:46:05 INFO - Running post-action listener: _resource_record_post_action 21:46:05 INFO - Running post-action listener: _start_resource_monitoring 21:46:05 INFO - Starting resource monitoring. 21:46:05 INFO - ##### 21:46:05 INFO - ##### Running install step. 21:46:05 INFO - ##### 21:46:05 INFO - Running pre-action listener: _resource_record_pre_action 21:46:05 INFO - Running main action method: install 21:46:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:46:05 INFO - Reading from file tmpfile_stdout 21:46:05 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:46:05 INFO - Reading from file tmpfile_stdout 21:46:05 INFO - Output received: 21:46:05 INFO - Usage: mozinstall [options] installer 21:46:05 INFO - Options: 21:46:05 INFO - -h, --help show this help message and exit 21:46:05 INFO - -d DEST, --destination=DEST 21:46:05 INFO - Directory to install application into. [default: 21:46:05 INFO - "/builds/slave/test-pgo"] 21:46:05 INFO - --app=APP Application being installed. [default: firefox] 21:46:05 INFO - mkdir: /builds/slave/test-pgo/build/application 21:46:05 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'] 21:46:05 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 21:46:21 INFO - Reading from file tmpfile_stdout 21:46:21 INFO - Output received: 21:46:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:46:21 INFO - Running post-action listener: _resource_record_post_action 21:46:21 INFO - ##### 21:46:21 INFO - ##### Running run-tests step. 21:46:21 INFO - ##### 21:46:21 INFO - Running pre-action listener: _resource_record_pre_action 21:46:21 INFO - Running main action method: run_tests 21:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:46:21 INFO - Python 2.7.3 21:46:21 INFO - Return code: 0 21:46:21 INFO - grabbing minidump binary from tooltool 21:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:21 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 0x146c540>, '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 0x146d440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146d8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:46:21 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 21:46:21 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 21:46:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:21 INFO - Return code: 0 21:46:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:46:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:46:22 INFO - Return code: 0 21:46:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:46:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:46:22 INFO - Using env: {'DISPLAY': ':0', 21:46:22 INFO - 'HOME': '/home/cltbld', 21:46:22 INFO - 'LANG': 'en_US.UTF-8', 21:46:22 INFO - 'LANGUAGE': 'en_US:en', 21:46:22 INFO - 'LOGNAME': 'cltbld', 21:46:22 INFO - 'MAIL': '/var/mail/cltbld', 21:46:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:22 INFO - 'MOZ_NO_REMOTE': '1', 21:46:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:46:22 INFO - 'NO_EM_RESTART': '1', 21:46:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:46:22 INFO - 'PWD': '/builds/slave/test-pgo', 21:46:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:46:22 INFO - 'SHELL': '/bin/bash', 21:46:22 INFO - 'SHLVL': '1', 21:46:22 INFO - 'TERM': 'linux', 21:46:22 INFO - 'TMOUT': '86400', 21:46:22 INFO - 'USER': 'cltbld', 21:46:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021', 21:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:22 INFO - '_': '/tools/buildbot/bin/python'} 21:46:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:46:22 INFO - mozversion application_buildid: 20160104193126 21:46:22 INFO - mozversion application_changeset: c8e48d86e37341c5b79ce7256a272edfbdf0043a 21:46:22 INFO - mozversion application_display_name: Nightly 21:46:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:22 INFO - mozversion application_name: Firefox 21:46:22 INFO - mozversion application_remotingname: firefox 21:46:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:46:22 INFO - mozversion application_vendor: Mozilla 21:46:22 INFO - mozversion application_version: 46.0a1 21:46:22 INFO - mozversion platform_buildid: 20160104193126 21:46:22 INFO - mozversion platform_changeset: c8e48d86e37341c5b79ce7256a272edfbdf0043a 21:46:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:46:22 INFO - mozversion platform_version: 46.0a1 21:46:22 INFO - using testdate: 1451972782 21:46:22 INFO - actual date: 1451972782 21:46:23 INFO - starting webserver on 'localhost:43698' 21:46:23 INFO - SUITE-START | Running 3 tests 21:46:23 INFO - TEST-START | dromaeo_css 21:46:23 INFO - operating with platform_type : linux_ 21:46:23 INFO - Initialising browser for dromaeo_css test... 21:46:23 INFO - TEST-INFO | started process 8631 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTcWrB0/profile http://localhost:43698/getInfo.html) 21:46:27 INFO - PROCESS | 8631 | __metrics Screen width/height:1600/1200 21:46:27 INFO - PROCESS | 8631 | colorDepth:24 21:46:27 INFO - PROCESS | 8631 | Browser inner width/height: 1024/697 21:46:27 INFO - PROCESS | 8631 | __metrics 21:46:27 INFO - PROCESS | 8631 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:46:28 INFO - TEST-INFO | 8631: exit 0 21:46:28 INFO - Browser initialized. 21:46:28 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:28 INFO - TEST-INFO | started process 8765 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTcWrB0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:46:40 INFO - PROCESS | 8765 | RSS: Main: 150781952 21:46:40 INFO - PROCESS | 8765 | 21:47:30 INFO - PROCESS | 8765 | 1451972850261 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] 21:49:38 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43698/tests/dromaeo/cssquery-ext.html) 21:49:40 INFO - PROCESS | 8765 | RSS: Main: 157274112 21:49:40 INFO - PROCESS | 8765 | 21:52:42 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-ext.html (next: http://localhost:43698/tests/dromaeo/cssquery-jquery.html) 21:52:42 INFO - PROCESS | 8765 | RSS: Main: 154406912 21:52:42 INFO - PROCESS | 8765 | 21:55:44 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43698/tests/dromaeo/cssquery-mootools.html) 21:55:45 INFO - PROCESS | 8765 | RSS: Main: 152993792 21:55:45 INFO - PROCESS | 8765 | 21:58:46 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43698/tests/dromaeo/cssquery-prototype.html) 21:58:47 INFO - PROCESS | 8765 | RSS: Main: 152268800 21:58:47 INFO - PROCESS | 8765 | 22:01:49 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43698/tests/dromaeo/cssquery-yui.html) 22:01:50 INFO - PROCESS | 8765 | RSS: Main: 152547328 22:01:50 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | Cycle 1(1): loaded http://localhost:43698/tests/dromaeo/cssquery-yui.html (next: http://localhost:43698/tests/dromaeo/cssquery-dojo.html) 22:04:52 INFO - PROCESS | 8765 | RSS: Main: 154767360 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | __start_tp_report 22:04:52 INFO - PROCESS | 8765 | _x_x_mozilla_page_load 22:04:52 INFO - PROCESS | 8765 | _x_x_mozilla_page_load_details 22:04:52 INFO - PROCESS | 8765 | |i|pagename|runs| 22:04:52 INFO - PROCESS | 8765 | |0;dojo.html;3113.5174048022554;3143.2613335866067;3181.7295529879957;3200.9359812803746;3213.068210219036;5121.487851214886;5266.4733526647315;5279.445658205886;5286.656367336121;5310.737271078206;5133.383993920735;5239.3712754469425;5266.052110620087;5298.20526920962;5311.707856067915;4480.372747815292;4745.335653008581;4928.67963582366;4948.851534453954;4985.576226020775;4703.764811759415;4844.685095468801;4903.411590609114;4919.089968355847;4947.332110165117;4678.859634210962;4745.90508189836;4803.039392121555;4836.8149803298065;4848.466668666461;4758.167320718895;4776.068666610013;4787.976060119677;4816.060868130681;4833.516648335173;4674.088552732219;4758.738269395182;4768.356271903318;4783.708398732323;4794.161021821167;5091.719955402451;5133.717645529495;5156.3296771419855;5174.068667639824;5188.610854185951;5705.115707065412;5714.571407144439;5725.599208055438;5738.8278351649515;5739.741711622987;5623.915641265385;5713.057345537981;5754.712264386764;5762.827115186551;5774.293831531049;5282.735863206824;5322.175062865262;5322.33470816148;5326.201069839516;5362.973185134049;5816.709164541756;5834.183214349994;5856.677882716406;5868.941310586925;5875.764969401176;5455.1271796512365;5550.639208451437;5583.357913839879;5605.915911261334;5627.380988091307;5666.4050274721385;5676.914846277309;5678.432156784371;5704.144378343199;5746.224259724967;5620.494155526022;5640.717964101778;5667.858303542444;5692;5717.22817419643;5515.696636684941;5616.354119276254;5629.211910332557;5680;5726.226959360516;4364.869053928387;4388.078503514298;4415.139047885696;4429.734215946989;4436.844710435119;3909.9609003910164;3932.410138479194;3941.9750864775365;3945.546262179886;3997.780122093313;5211.1922651989;5291.682499050069;5336.813211537655;5401.189821526724;5438.075527160392;5607.467290607386;5669;5690.5447564194765;5713.200151978726;5732.885342293131;5176.50823171798;5356.196570514454;5377.5160235578205;5377.623566350318;5420.376656684453;4840.491748366441;4886.29148773433;4894.975525122351;4931.457539670633;4945.604351651859;5962.1056841473255;5986.102084687332;5989.341172471025;5989.460948514655;6008.309044459943;5512.3385193777;5614.04561224601;5723.885522289447;5726;5745.2818397700285;5898.085796701518;5921.703914804329;5956.642601443928;5989.431004054608;5993.520518358608;5596.580256480862;5606.523445507014;5607.327120745536;5608.495235428831;5617.887642247214;5563.666180029211;5662.065759149694;5669.4047125051275;5691.032524470767;5711.143328500758;5604.355499117653;5604.607677462538;5614.354349249726;5622.718864056699;5651.83044508649;5554.055810512142;5573.359063707726;5580.720963951705;5586.692731899784;5589.217509548747;5314.62797604164;5410.1343784994215;5417.783288668409;5428.7557059931605;5491.121420572849;5461.9453805461435;5490.176473529003;5630.014747419267;5681.659100453986;5729.742161602655;5410.404855465817;5430.13117901134;5433.347998240237;5441.483059109379;5482.28730265079 22:04:52 INFO - PROCESS | 8765 | |1;ext.html;526.9881826892366;528.6748649580506;531.2191079113702;554.3458718711921;563.6251892491493;34396.656033439656;35767;35795.82102089486;35796.821015894915;35818.64181358185;39388;39726.801365993204;39764.20471590574;39769.403458948065;39885.60114398855;8335.374846886492;8512.1487851215;8518.40371174015;8523.232909038185;8543;8314.792130196733;8419;8436.409451338379;8623.267022303111;8688.56557172142;8540.188682075193;8600.784980375478;8607.225349718556;8618;8672.60973256205;8545.401821872472;8554.443961142506;8582.313414926854;8595;8603.827923441528;8338.83322333556;8565.486070835708;8573.356998225157;8588.570571471464;8596.097409772008;38417;38921.61078389208;38934.22131557381;39146.412803807965;39184.02039948996;3128;3141.4502462069277;3415.9658403415897;3510.438329867209;3910.960890391088;28774.568381474295;29172.854135729398;29244.415111697646;29446.263843404085;30121;3522.6829585337186;3531.1525233943926;3533.2403533240476;3562.340966921128;3577.123604716835;253551;257096;257521;257644;259028.9999999981;52636.73681631567;53523.46476535185;58789.41210587925;60130.39869601248;60265.69867150636;53596.464035359924;54113.45886541163;54134.18798718022;54183.03986561475;54384.728076359366;14865.479708210161;14929.850701493064;15061.472848450252;15084.396624135132;15139;11403.258788178742;11423.428828558539;11539.307641541534;11806.409679516162;11856.940715296369;19576.3148289812;19863.30478433248;19879.60240795176;19890.801091989186;19898.403047908585;7872.606369681493;8040.557769322626;8094.109647938722;8106.918930810734;8138.552379619177;865.9870101948476;880.1550511508896;959.5058544849409;1090.7612521939163;1097.3964319624174;27399.86300068527;27733.722662773114;27868.860655696997;28055.71944280531;28213.294667633472;970.684527528556;994.6966175316597;996.6113215845826;1025.108155904368;1036.9533370998324;14328.355224014944;14344.856551434352;14410.279486025656;14469.421223151166;14713.55859324222;303228;305987;306324;306639;307122;49470;49800;50124.240681949;50137.74931125394;50323;1279.923204607708;1280.801475771257;1281.6923938254752;1290.2903403128241;1295.4235365262368;26427.207183784518;27126;27281.59077613798;27326.863365683046;27570.448591028467;40021.39967900426;40024.799876000434;40075.59924400835;40246.1950760989;40293.19413611653;268065;271709;272330;272955;273372;31615.36769264648;42081.57918420899;42206;43054.78472607617;43150.35274470948;44181.55818441774;45597.54402456066;46386.30420543762;46432;46572.30141547812;32875.17812054718;33302;33802.154946125556;34042;34262;39342.803285983384;40128;40246;42874.356884646135;44762;35893.64106358903;35951.640483595875;36371.27257454889;36444.81777591201;36666;36525.64783163063;38331;38466.42300365441;39070.67899228484;39398.80300598479;29353.559696604996;29603.259918502208;29854.70145298519;30195;30286.54570181405 22:04:52 INFO - PROCESS | 8765 | |2;jquery.html;358.5661349766782;359.5667220998697;362.3477740067877;363.50018724254153;366.3387585408337;16134;16738.665226695473;17396.913015434937;17614.73577896331;17970.281188752433;9925.255605829556;9995.15041221497;10218.233632477575;10282.845757313627;10305.278630495868;4853.563179313852;4867;4975.179095449246;4981.103401387749;4982.975085124569;5266.289050978126;5328.813491527797;5331.57347412208;5333.599980001496;5333.919991200135;4822.541858523452;5053.444121146671;5055.873603159914;5283.762230699628;5293.444188360225;4967.751612419364;4979.053979743837;4988.052270068693;4989.525995030466;5446.809361672323;5254.579633629301;5299.1786273127345;5303.496167864047;5321.73391330432;5324.361076670824;10691.518881650345;10995;16334.34662613494;19971.700424493643;20001.699974500396;1990.9004549772453;1997.1911375892787;2077.4390914453015;2121.3847984084596;2150.0109949423127;8485.83028339436;8677.652893884237;9014.278857691435;9056.275497960214;9178.67874624385;1615.5557221764109;1636.0919689572283;1659.0875018739646;1663.1601041474098;1687.9578010549712;58011;59457.7027114866;59535.534834887556;59736;60358.39641603616;9953.751156221007;10141.645042423479;10212.744681383025;10227;10270.845937310947;13239.404226809816;13302.46790128384;13321;13326.800097998537;13347.599572012856;7365.963170184222;7397.926020739831;7458.179600243969;7549.6225188740345;7625.351845093118;6941.444684425234;7004.824879378057;7033.6483175841;7064.682089305994;7068.293170682993;4215.768132752667;4229.851955181615;4312.353147027909;4347.130573885235;4411.558844115627;1833.367488216563;1856.7214917762444;1885.1893685715274;1896.2415033986515;1897.7627796525435;871.7210492642294;890.4034297021011;1031.6131450705984;1040.6929955663097;1057.709129989259;10758;13984.021118521607;15953.601159970862;16165.515034548982;16447.342106315853;408.78538767147484;417.20730611837143;420.2100051902465;423.8050496771458;438.09533313707095;5368.5436737876935;5394.91907621386;5597.80407685729;5606.299212598426;5691.686957217393;515581;523222;528304;534608;541605;82230.58884705658;82782.58608706918;86898;87006.12993870107;88616.556917215;452.60171049476253;455.09890416974577;457.62932025059143;468.8405941979743;469.9459562150328;10575.788484230427;10742.194335424718;10749.14006879432;14885.776713349525;15499.868266032981;34312;34852;35912.281754364245;36000.639993599725;36367.81816091009;47132.29301560411;47196;47651;47942;48121.518784811706;9023.278137749096;9395.2953528487;9482.38364506305;9522.47626380528;9816.312858099864;17746.11269436549;17880.55298617493;17953.102344882966;18061.909690451463;18533.53666158357;13668.726625467634;13986.790198146833;14364.85635143677;14377.28113594337;14398.42406303736;13704.177749335071;14091.436342546593;14400.279986000449;14582;14784.260786960394;14307.427702892184;14814.77777833355;15001.549953501413;15255.847441525886;15276.923615381851;9113.544322783702;9282.814343713222;9598.856017159887;10053.648122315684;10057.798844023226;14593.270336482921;14896.180710061051;15093.094414335175;15180.165090920105;15294.388224470897 22:04:52 INFO - PROCESS | 8765 | |3;mootools.html;1348.9123206991542;1357.3009899901551;1494.2230040379004;1753.1409609291452;1794.999999999999;6279.968600156993;6320.115183874262;7630.809229769252;7664.92335076649;7670.5014174078715;7171.175314838795;7210.4952653314285;7294.927050729491;7329.413646908248;7358.484906056578;2126.8298536117113;2164.9242276520326;2176.6299729046023;2177.477405422703;2177.858439201447;2126.6597344424895;2134.583756167548;2245.5059886824874;2254.5265494246228;2263.094762095167;2201.03154611971;2201.1305534313938;2235.005422586941;2239.473723674935;2243.05791567542;2184.726909136358;2188.1684959715367;2201.108551036825;2202.2072054060527;2205.37146913129;2180.6292930201903;2223.088533701191;2225.0765932138142;2228.576570451609;2229.4203507088114;7527.736529221451;7580.128285247212;7580.469367144302;7593.08882934046;7604.239576042407;4432.468103827529;4491.326301054835;4494.438195225597;4503.842365517191;4511.368408422823;2887.3070463088916;2904.143277733074;2917.0811194473886;2933.7946343755943;2966.362232120083;960.6493629825063;997.5012493753123;1013.716159475348;1020.7090979071004;1026.743314171457;10051.346662466989;10214.948925255401;10216.74458138545;10245.84631230532;10258.7435314117;3926.54844692864;3969.1069509360163;3982.761034337949;4021.5777343378522;4052.0477687743355;8671.6531338747;8765.43024703405;8777.42946708462;8799.25206357454;8814.118588141262;4467.776611169428;4502.482214545369;4515.774211289422;4522.954770452254;4537.047220083819;4087.1212689271947;4092.7339722917914;4111.9177616447505;4153.937690934638;4168.895777605584;3355.345707586997;3424.6917777400154;3425.2806910549066;3455.36075825973;3480.3735327641266;1025.676911772804;1034.6533911139702;1035.9015893490107;1037.6108959140322;1038.43924280889;1311.7376524694907;1318.821959035518;1324.2319454716242;1327.6548097494722;1342.8589998050259;7156.570605763671;7223.494355395072;7310.268973102648;7332.376747976482;7336.449766267551;483.5092381233051;483.84033269021137;490.14959046055066;491.5944345914635;492.1264755059797;5634.211210430543;5643.097104463266;5664.603477756517;5673.914891276634;5698.544116470673;8760.649574017096;8848;8908;8956.507392093366;8986.460812351279;8822;8822.86765698515;8836.248918841971;8886.777830554158;8892.244159246407;6600.768973085919;6693.899591506131;6718.22740384862;6747.696353663999;6784.626845523544;7032.050673159058;7089.326513981164;7114.430845532242;7120.572765634079;7133.179684336368;8015.47899386538;8195.016598008038;8224.62989165501;8294.834103317778;8390.286825619647;8248.793780155544;8365.456245344034;8372.45579037385;8382.37132215074;8412.453190542596;5758.366579676316;5841.094630332305;6339.429451349401;6345.3654634538025;6414.262359828493;7223.674934628059;7223.8555228896175;7224.313690199423;7247.166575843846;7282.745103921337;6441.854698735433;6960.721571137098;6982.1272340957385;7036.190838053484;7040.929590704028;6833.863322733617;6851.862962740817;6874.793756187322;6922.134733158356;6938.61227754441;6813.69338379784;6858.6227757471825;6893.965530172317;6926.792196234121;6930.203026652;6310.905336420049;6336.651484168415;6338.239411270677;6372.713227904848;6377.8724425512155;6477.157969464128;6485;6485.935140648533;6536.117624120873;6551.639659818565 22:04:52 INFO - PROCESS | 8765 | |4;prototype.html;333.8414253229716;336.81306874684543;338.6156712131733;344.546920799149;344.89825501477077;6173.888700033997;6203.255609326881;6235.158253635758;6251;6293;6163.075538669202;6182;6199.132121502993;6214.03682429223;6242.968785156079;4698.295255711637;4711.858644240661;4735.266033764772;4756.28655701644;4770.0936822003705;4742.454617718955;4753.215719406311;4755.286706993961;4765.26138448541;4769.5707386335225;4519.079391258719;4553.817847286121;4617.6536759742985;4630.236011058171;4676.3453116563705;4590.242609969351;4597.908041839161;4601.033782905593;4607.884802879921;4619.16854966106;4007.338789099795;4036.414719865603;4074.9796251018556;4078.163976384834;4083.673306135502;5900.1739756434135;5922.31893332268;5936.821895343147;5945.137954996501;5946.256717910262;5279.076161671692;5392.730363481849;5415.350157981067;5455.754491047913;5463.31708536433;6380.1705778249;6421.839454013687;6427.453666438359;6438.066480360369;6529.869402611921;4488.192125417424;4497.527759585262;4502.774861256957;4508.188526065307;4508.504064552896;6670.4997125215805;6850.349216824394;6865.828354291183;6870;6884.896726549106;4504.977475112603;4583.220852455091;4592.816287348535;4597.540245975376;4613.0312634347165;4643.605293550018;4647.930281045787;4657.4876763555985;4662.976685116552;4675.368825208621;5428.70142142186;5444.455554444603;5450.91823622646;5455.509004189642;5459.890802183934;6531.052997315458;6630.502712296597;6631.86736265272;6643.036759669821;6646.368594983469;1634.5014770494874;1658.29522452957;1661.5846038490376;1662.9523400258001;1665.2173478465102;1069.994650026745;1090.4983707494482;1093.4478088565384;1103.906167975715;1105.5080489182237;6328.557001009885;6340.841478963062;6343.9682801585695;6361.713722882481;6370.968145159337;6768.7292508299115;6782.152230971129;6813.693383797741;6817.045613614098;6831.897521537181;6215.81352559424;6305.873882522324;6322.525810564226;6329.715162817684;6384.648844313514;3705.40713485841;3720.311742327678;3725.813709314578;3732.6080761520193;3743.47591337213;7236.059312289474;7243.963780181065;7245.89131163033;7249.927500724925;7251.746188883364;6826.624535650587;6991.23096459389;7002.614856182857;7042.154941407064;7044.15470143586;7209.062821833233;7222.241664625139;7233.914912763023;7234;7241.275872412716;6819.556728812611;6829.453643708591;6864.519483636098;6867.381935625618;6874.140732408449;6650.334966503311;6775.830604234933;6777.1189745332795;6778.8644227116165;6781.050652908695;7168.820779480555;7182.784516464514;7183.461240407095;7222.855542889218;7233.1681856587165;4555.20283950314;4566.109608626286;4585.358049872953;4593.54064593538;4594.747288899009;6802.795916122524;6803.387695107464;6880.346367095118;6908.965455172692;6919.065926099912;6635.834104147435;6640.203175618956;6678.49911256648;6678.632675202911;6683.498737594603;6566.8358291043105;6660.6336651484635;6679.298673639198;6679.9332006679315;6691.5650482718465;6528.771492997722;6558.081868538313;6558.245801732862;6560.147180866456;6568.573042752206;6702.128723265944;6708.758879607289;6710.362515561014;6716.529842910949;6716.966415167893;6402.103705481143;6550.705218265094;6551.574147680385;6564.934350656624;6572.507061970276 22:04:52 INFO - PROCESS | 8765 | |5;yui.html;802.4062193976457;842.7850898021004;857.9184977427144;861.5519929636589;889.4485419040196;13371.465141394345;13640.31798410078;13674.247916364597;13683.24742139182;13693.246871422069;12003.159778815487;12004.279743215413;12012.099092568049;12087.516499340038;12103.394830258496;667.2960027171332;668.582136164897;786.1666633368619;796.3072127249287;823.3289868756943;806.4153488720689;816.3061397811872;818.5088946632033;824.2664029014182;825.2861274997144;860.2859626510013;867;867.7743786615493;869.3349587565517;869.586946200556;852.6333676519095;854.9102344253857;855.2132038524572;856.2251162697769;863.5034854958393;630.8107567729709;633.7528363938068;634.5431289471574;638.8370965403839;643.9066335381343;13347.466101355934;13499.527516536973;13517.121387109806;13608.659783505393;13623.386947587283;12013.87986120145;12161.087918406067;12186.75626487474;12436.19164754288;12981.610551683465;9477.194438472738;9539.332246742732;9711.125998660154;9948.761528655994;10016.79966400668;3567.500549923013;3608.9097772555633;3635.2184280379847;3672.559292884871;3759.8684046058256;47021.76489117533;47068.29397559039;47537;47655.5234447658;47834.28248576309;9645.37305075168;9744.902550974399;9902.801943961225;10003.199744020461;10244.282900197064;18596.163172657263;18698.626027479648;18798.154083066296;18807.717884231748;18926.716099258523;7268.927310726825;7340.889886651705;7352.77941661751;7387.7783666490095;7504.887426688604;4101.077257617012;4228.450301460791;4240.469941257343;4241.215375155606;4255.255330317182;3107.2697915989725;3145.040762567439;3145.8741650334186;3148.8268145251773;3155.6213254409618;560.3723829311198;565.9236003139523;580.4717706886713;582.2837909371412;588.0796553393925;471.1613328275675;472.3363674037982;501.36076502459656;504.6114491841335;533.7651433369305;7773.144954055162;7882.330001949898;8070.878936815952;8345.457545259538;8413.70552030676;496.5580633236423;517.76959253132;527.8179028235253;536.9221462887859;590.8847774683982;3888.8833334999995;3901.317269477887;4030.173814368106;4060.309747342959;4068.572799856032;49761.75119124381;50511.49488505068;50512.49487505152;50522.49477505252;50637;45033.54966450359;45576.772116139204;45758.54241457543;46121.53878461172;46321.76839115783;43544.564554354685;44227.11545769066;44412.111757764666;45137.32294015592;45541.54458455373;8296.83406331858;8376.832463350576;8380.53907035119;8429.747107586782;8543.91456085456;32895.83552082224;33570.832145839115;33722.66277337195;34195.82902085473;34348.14129646779;39362;42249;42565.36151957661;43467.56532434762;43909.12181756411;10011.39931604077;10134.189264858942;10781.730456738644;11226;11447.370394628375;11860.525578976743;12057.095717821023;12114.939425302817;12398.876011239772;12735.172213806072;11240.55037798479;11361.147913906325;11461.4269286537;11523.654290371302;11793.941030295136;11157.888421115686;11504.424778760862;11511.30932144074;11935.104867134825;11980.520779169085;10710.250282480152;11047.226694131334;11244.55021799119;11416.257943233662;11527.250728702607;9684.761125197161;9816.26378021637;9894.257930655374;9998.600055997678;10217;8861.202491775772;8922.509261990654;9211.953940230524;9774.12032917041;9861.556229969812 22:04:52 INFO - PROCESS | 8765 | __end_tp_report 22:04:52 INFO - PROCESS | 8765 | __start_cc_report 22:04:52 INFO - PROCESS | 8765 | _x_x_mozilla_cycle_collect,319 22:04:52 INFO - PROCESS | 8765 | __end_cc_report 22:04:52 INFO - PROCESS | 8765 | __startTimestamp1451973892965__endTimestamp 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | ------- Summary: start ------- 22:04:52 INFO - PROCESS | 8765 | Number of tests: 6 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#0] dojo.html Cycles:165 Average:5277.28 Median:5441.48 stddev:593.19 (10.9%) stddev-sans-first:570.21 22:04:52 INFO - PROCESS | 8765 | Values: 3113.5 3143.3 3181.7 3200.9 3213.1 5121.5 5266.5 5279.4 5286.7 5310.7 5133.4 5239.4 5266.1 5298.2 5311.7 4480.4 4745.3 4928.7 4948.9 4985.6 4703.8 4844.7 4903.4 4919.1 4947.3 4678.9 4745.9 4803.0 4836.8 4848.5 4758.2 4776.1 4788.0 4816.1 4833.5 4674.1 4758.7 4768.4 4783.7 4794.2 5091.7 5133.7 5156.3 5174.1 5188.6 5705.1 5714.6 5725.6 5738.8 5739.7 5623.9 5713.1 5754.7 5762.8 5774.3 5282.7 5322.2 5322.3 5326.2 5363.0 5816.7 5834.2 5856.7 5868.9 5875.8 5455.1 5550.6 5583.4 5605.9 5627.4 5666.4 5676.9 5678.4 5704.1 5746.2 5620.5 5640.7 5667.9 5692.0 5717.2 5515.7 5616.4 5629.2 5680.0 5726.2 4364.9 4388.1 4415.1 4429.7 4436.8 3910.0 3932.4 3942.0 3945.5 3997.8 5211.2 5291.7 5336.8 5401.2 5438.1 5607.5 5669.0 5690.5 5713.2 5732.9 5176.5 5356.2 5377.5 5377.6 5420.4 4840.5 4886.3 4895.0 4931.5 4945.6 5962.1 5986.1 5989.3 5989.5 6008.3 5512.3 5614.0 5723.9 5726.0 5745.3 5898.1 5921.7 5956.6 5989.4 5993.5 5596.6 5606.5 5607.3 5608.5 5617.9 5563.7 5662.1 5669.4 5691.0 5711.1 5604.4 5604.6 5614.4 5622.7 5651.8 5554.1 5573.4 5580.7 5586.7 5589.2 5314.6 5410.1 5417.8 5428.8 5491.1 5461.9 5490.2 5630.0 5681.7 5729.7 5410.4 5430.1 5433.3 5441.5 5482.3 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#1] ext.html Cycles:180 Average:45070.92 Median:38374.00 stddev:72661.86 (189.4%) stddev-sans-first:72788.72 22:04:52 INFO - PROCESS | 8765 | Values: 527.0 528.7 531.2 554.3 563.6 34396.7 35767.0 35795.8 35796.8 35818.6 39388.0 39726.8 39764.2 39769.4 39885.6 8335.4 8512.1 8518.4 8523.2 8543.0 8314.8 8419.0 8436.4 8623.3 8688.6 8540.2 8600.8 8607.2 8618.0 8672.6 8545.4 8554.4 8582.3 8595.0 8603.8 8338.8 8565.5 8573.4 8588.6 8596.1 38417.0 38921.6 38934.2 39146.4 39184.0 3128.0 3141.5 3416.0 3510.4 3911.0 28774.6 29172.9 29244.4 29446.3 30121.0 3522.7 3531.2 3533.2 3562.3 3577.1 253551.0 257096.0 257521.0 257644.0 259029.0 52636.7 53523.5 58789.4 60130.4 60265.7 53596.5 54113.5 54134.2 54183.0 54384.7 14865.5 14929.9 15061.5 15084.4 15139.0 11403.3 11423.4 11539.3 11806.4 11856.9 19576.3 19863.3 19879.6 19890.8 19898.4 7872.6 8040.6 8094.1 8106.9 8138.6 866.0 880.2 959.5 1090.8 1097.4 27399.9 27733.7 27868.9 28055.7 28213.3 970.7 994.7 996.6 1025.1 1037.0 14328.4 14344.9 14410.3 14469.4 14713.6 303228.0 305987.0 306324.0 306639.0 307122.0 49470.0 49800.0 50124.2 50137.7 50323.0 1279.9 1280.8 1281.7 1290.3 1295.4 26427.2 27126.0 27281.6 27326.9 27570.4 40021.4 40024.8 40075.6 40246.2 40293.2 268065.0 271709.0 272330.0 272955.0 273372.0 31615.4 42081.6 42206.0 43054.8 43150.4 44181.6 45597.5 46386.3 46432.0 46572.3 32875.2 33302.0 33802.2 34042.0 34262.0 39342.8 40128.0 40246.0 42874.4 44762.0 35893.6 35951.6 36371.3 36444.8 36666.0 36525.6 38331.0 38466.4 39070.7 39398.8 29353.6 29603.3 29854.7 30195.0 30286.5 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#2] jquery.html Cycles:180 Average:28125.18 Median:4222.81 stddev:86606.40 (2050.9%) stddev-sans-first:86824.25 22:04:52 INFO - PROCESS | 8765 | Values: 358.6 359.6 362.3 363.5 366.3 16134.0 16738.7 17396.9 17614.7 17970.3 9925.3 9995.2 10218.2 10282.8 10305.3 4853.6 4867.0 4975.2 4981.1 4983.0 5266.3 5328.8 5331.6 5333.6 5333.9 4822.5 5053.4 5055.9 5283.8 5293.4 4967.8 4979.1 4988.1 4989.5 5446.8 5254.6 5299.2 5303.5 5321.7 5324.4 10691.5 10995.0 16334.3 19971.7 20001.7 1990.9 1997.2 2077.4 2121.4 2150.0 8485.8 8677.7 9014.3 9056.3 9178.7 1615.6 1636.1 1659.1 1663.2 1688.0 58011.0 59457.7 59535.5 59736.0 60358.4 9953.8 10141.6 10212.7 10227.0 10270.8 13239.4 13302.5 13321.0 13326.8 13347.6 7366.0 7397.9 7458.2 7549.6 7625.4 6941.4 7004.8 7033.6 7064.7 7068.3 4215.8 4229.9 4312.4 4347.1 4411.6 1833.4 1856.7 1885.2 1896.2 1897.8 871.7 890.4 1031.6 1040.7 1057.7 10758.0 13984.0 15953.6 16165.5 16447.3 408.8 417.2 420.2 423.8 438.1 5368.5 5394.9 5597.8 5606.3 5691.7 515581.0 523222.0 528304.0 534608.0 541605.0 82230.6 82782.6 86898.0 87006.1 88616.6 452.6 455.1 457.6 468.8 469.9 10575.8 10742.2 10749.1 14885.8 15499.9 34312.0 34852.0 35912.3 36000.6 36367.8 47132.3 47196.0 47651.0 47942.0 48121.5 9023.3 9395.3 9482.4 9522.5 9816.3 17746.1 17880.6 17953.1 18061.9 18533.5 13668.7 13986.8 14364.9 14377.3 14398.4 13704.2 14091.4 14400.3 14582.0 14784.3 14307.4 14814.8 15001.5 15255.8 15276.9 9113.5 9282.8 9598.9 10053.6 10057.8 14593.3 14896.2 15093.1 15180.2 15294.4 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#3] mootools.html Cycles:180 Average:5243.22 Median:6295.44 stddev:2732.86 (43.4%) stddev-sans-first:2724.85 22:04:52 INFO - PROCESS | 8765 | Values: 1348.9 1357.3 1494.2 1753.1 1795.0 6280.0 6320.1 7630.8 7664.9 7670.5 7171.2 7210.5 7294.9 7329.4 7358.5 2126.8 2164.9 2176.6 2177.5 2177.9 2126.7 2134.6 2245.5 2254.5 2263.1 2201.0 2201.1 2235.0 2239.5 2243.1 2184.7 2188.2 2201.1 2202.2 2205.4 2180.6 2223.1 2225.1 2228.6 2229.4 7527.7 7580.1 7580.5 7593.1 7604.2 4432.5 4491.3 4494.4 4503.8 4511.4 2887.3 2904.1 2917.1 2933.8 2966.4 960.6 997.5 1013.7 1020.7 1026.7 10051.3 10214.9 10216.7 10245.8 10258.7 3926.5 3969.1 3982.8 4021.6 4052.0 8671.7 8765.4 8777.4 8799.3 8814.1 4467.8 4502.5 4515.8 4523.0 4537.0 4087.1 4092.7 4111.9 4153.9 4168.9 3355.3 3424.7 3425.3 3455.4 3480.4 1025.7 1034.7 1035.9 1037.6 1038.4 1311.7 1318.8 1324.2 1327.7 1342.9 7156.6 7223.5 7310.3 7332.4 7336.4 483.5 483.8 490.1 491.6 492.1 5634.2 5643.1 5664.6 5673.9 5698.5 8760.6 8848.0 8908.0 8956.5 8986.5 8822.0 8822.9 8836.2 8886.8 8892.2 6600.8 6693.9 6718.2 6747.7 6784.6 7032.1 7089.3 7114.4 7120.6 7133.2 8015.5 8195.0 8224.6 8294.8 8390.3 8248.8 8365.5 8372.5 8382.4 8412.5 5758.4 5841.1 6339.4 6345.4 6414.3 7223.7 7223.9 7224.3 7247.2 7282.7 6441.9 6960.7 6982.1 7036.2 7040.9 6833.9 6851.9 6874.8 6922.1 6938.6 6813.7 6858.6 6894.0 6926.8 6930.2 6310.9 6336.7 6338.2 6372.7 6377.9 6477.2 6485.0 6485.9 6536.1 6551.6 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#4] prototype.html Cycles:180 Average:5518.67 Median:6299.44 stddev:1697.32 (26.9%) stddev-sans-first:1656.86 22:04:52 INFO - PROCESS | 8765 | Values: 333.8 336.8 338.6 344.5 344.9 6173.9 6203.3 6235.2 6251.0 6293.0 6163.1 6182.0 6199.1 6214.0 6243.0 4698.3 4711.9 4735.3 4756.3 4770.1 4742.5 4753.2 4755.3 4765.3 4769.6 4519.1 4553.8 4617.7 4630.2 4676.3 4590.2 4597.9 4601.0 4607.9 4619.2 4007.3 4036.4 4075.0 4078.2 4083.7 5900.2 5922.3 5936.8 5945.1 5946.3 5279.1 5392.7 5415.4 5455.8 5463.3 6380.2 6421.8 6427.5 6438.1 6529.9 4488.2 4497.5 4502.8 4508.2 4508.5 6670.5 6850.3 6865.8 6870.0 6884.9 4505.0 4583.2 4592.8 4597.5 4613.0 4643.6 4647.9 4657.5 4663.0 4675.4 5428.7 5444.5 5450.9 5455.5 5459.9 6531.1 6630.5 6631.9 6643.0 6646.4 1634.5 1658.3 1661.6 1663.0 1665.2 1070.0 1090.5 1093.4 1103.9 1105.5 6328.6 6340.8 6344.0 6361.7 6371.0 6768.7 6782.2 6813.7 6817.0 6831.9 6215.8 6305.9 6322.5 6329.7 6384.6 3705.4 3720.3 3725.8 3732.6 3743.5 7236.1 7244.0 7245.9 7249.9 7251.7 6826.6 6991.2 7002.6 7042.2 7044.2 7209.1 7222.2 7233.9 7234.0 7241.3 6819.6 6829.5 6864.5 6867.4 6874.1 6650.3 6775.8 6777.1 6778.9 6781.1 7168.8 7182.8 7183.5 7222.9 7233.2 4555.2 4566.1 4585.4 4593.5 4594.7 6802.8 6803.4 6880.3 6909.0 6919.1 6635.8 6640.2 6678.5 6678.6 6683.5 6566.8 6660.6 6679.3 6679.9 6691.6 6528.8 6558.1 6558.2 6560.1 6568.6 6702.1 6708.8 6710.4 6716.5 6717.0 6402.1 6550.7 6551.6 6564.9 6572.5 22:04:52 INFO - PROCESS | 8765 | 22:04:52 INFO - PROCESS | 8765 | [#5] yui.html Cycles:180 Average:13218.91 Median:45667.66 stddev:14776.83 (32.4%) stddev-sans-first:14788.86 22:04:52 INFO - PROCESS | 8765 | Values: 802.4 842.8 857.9 861.6 889.4 13371.5 13640.3 13674.2 13683.2 13693.2 12003.2 12004.3 12012.1 12087.5 12103.4 667.3 668.6 786.2 796.3 823.3 806.4 816.3 818.5 824.3 825.3 860.3 867.0 867.8 869.3 869.6 852.6 854.9 855.2 856.2 863.5 630.8 633.8 634.5 638.8 643.9 13347.5 13499.5 13517.1 13608.7 13623.4 12013.9 12161.1 12186.8 12436.2 12981.6 9477.2 9539.3 9711.1 9948.8 10016.8 3567.5 3608.9 3635.2 3672.6 3759.9 47021.8 47068.3 47537.0 47655.5 47834.3 9645.4 9744.9 9902.8 10003.2 10244.3 18596.2 18698.6 18798.2 18807.7 18926.7 7268.9 7340.9 7352.8 7387.8 7504.9 4101.1 4228.5 4240.5 4241.2 4255.3 3107.3 3145.0 3145.9 3148.8 3155.6 560.4 565.9 580.5 582.3 588.1 471.2 472.3 501.4 504.6 533.8 7773.1 7882.3 8070.9 8345.5 8413.7 496.6 517.8 527.8 536.9 590.9 3888.9 3901.3 4030.2 4060.3 4068.6 49761.8 50511.5 50512.5 50522.5 50637.0 45033.5 45576.8 45758.5 46121.5 46321.8 43544.6 44227.1 44412.1 45137.3 45541.5 8296.8 8376.8 8380.5 8429.7 8543.9 32895.8 33570.8 33722.7 34195.8 34348.1 39362.0 42249.0 42565.4 43467.6 43909.1 10011.4 10134.2 10781.7 11226.0 11447.4 11860.5 12057.1 12114.9 12398.9 12735.2 11240.6 11361.1 11461.4 11523.7 11793.9 11157.9 11504.4 11511.3 11935.1 11980.5 10710.3 11047.2 11244.6 11416.3 11527.3 9684.8 9816.3 9894.3 9998.6 10217.0 8861.2 8922.5 9212.0 9774.1 9861.6 22:04:52 INFO - PROCESS | 8765 | -------- Summary: end -------- 22:04:52 INFO - PROCESS | 8765 | 22:04:53 INFO - TEST-INFO | 8765: exit 0 22:04:53 INFO - TEST-OK | dromaeo_css | took 1110659ms 22:04:53 INFO - TEST-START | kraken 22:04:53 INFO - operating with platform_type : linux_ 22:04:53 INFO - Initialising browser for kraken test... 22:04:53 INFO - TEST-INFO | started process 9005 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYnRO4l/profile http://localhost:43698/getInfo.html) 22:04:58 INFO - PROCESS | 9005 | __metrics Screen width/height:1600/1200 22:04:58 INFO - PROCESS | 9005 | colorDepth:24 22:04:58 INFO - PROCESS | 9005 | Browser inner width/height: 1024/697 22:04:58 INFO - PROCESS | 9005 | __metrics 22:04:58 INFO - PROCESS | 9005 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:04:58 INFO - PROCESS | 9005 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:04:59 INFO - TEST-INFO | 9005: exit 0 22:04:59 INFO - Browser initialized. 22:04:59 INFO - Running cycle 1/1 for kraken test... 22:04:59 INFO - TEST-INFO | started process 9127 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYnRO4l/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:11 INFO - PROCESS | 9127 | RSS: Main: 150798336 22:05:11 INFO - PROCESS | 9127 | 22:05:13 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43698/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:14 INFO - PROCESS | 9127 | RSS: Main: 152088576 22:05:14 INFO - PROCESS | 9127 | 22:05:16 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43698/tests/kraken/driver.html?testName=audio-dft) 22:05:17 INFO - PROCESS | 9127 | RSS: Main: 151810048 22:05:17 INFO - PROCESS | 9127 | 22:05:20 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43698/tests/kraken/driver.html?testName=audio-fft) 22:05:20 INFO - PROCESS | 9127 | RSS: Main: 146866176 22:05:20 INFO - PROCESS | 9127 | 22:05:22 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43698/tests/kraken/driver.html?testName=audio-oscillator) 22:05:23 INFO - PROCESS | 9127 | RSS: Main: 146579456 22:05:23 INFO - PROCESS | 9127 | 22:05:25 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43698/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:26 INFO - PROCESS | 9127 | RSS: Main: 146989056 22:05:26 INFO - PROCESS | 9127 | 22:05:29 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43698/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:29 INFO - PROCESS | 9127 | RSS: Main: 147730432 22:05:29 INFO - PROCESS | 9127 | 22:05:33 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43698/tests/kraken/driver.html?testName=imaging-desaturate) 22:05:33 INFO - PROCESS | 9127 | RSS: Main: 149139456 22:05:33 INFO - PROCESS | 9127 | 22:05:36 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43698/tests/kraken/driver.html?testName=json-parse-financial) 22:05:37 INFO - PROCESS | 9127 | RSS: Main: 147087360 22:05:37 INFO - PROCESS | 9127 | 22:05:38 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43698/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:05:39 INFO - PROCESS | 9127 | RSS: Main: 148037632 22:05:39 INFO - PROCESS | 9127 | 22:05:41 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:05:41 INFO - PROCESS | 9127 | RSS: Main: 149090304 22:05:41 INFO - PROCESS | 9127 | 22:05:44 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:05:44 INFO - PROCESS | 9127 | RSS: Main: 148766720 22:05:44 INFO - PROCESS | 9127 | 22:05:47 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:05:47 INFO - PROCESS | 9127 | RSS: Main: 148582400 22:05:47 INFO - PROCESS | 9127 | 22:05:50 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:05:50 INFO - PROCESS | 9127 | RSS: Main: 148709376 22:05:50 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | Cycle 1(1): loaded http://localhost:43698/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43698/tests/kraken/driver.html?testName=ai-astar) 22:05:52 INFO - PROCESS | 9127 | RSS: Main: 149708800 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | __start_tp_report 22:05:52 INFO - PROCESS | 9127 | _x_x_mozilla_page_load 22:05:52 INFO - PROCESS | 9127 | _x_x_mozilla_page_load_details 22:05:52 INFO - PROCESS | 9127 | |i|pagename|runs| 22:05:52 INFO - PROCESS | 9127 | |0;ai-astar;112;109;112;111;111;123;112;113;110;110 22:05:52 INFO - PROCESS | 9127 | |1;audio-beat-detection;153;127;152;160;125;156;150;129;167;126 22:05:52 INFO - PROCESS | 9127 | |2;audio-dft;162;163;162;162;166;163;162;164;174;164 22:05:52 INFO - PROCESS | 9127 | |3;audio-fft;72;71;71;73;72;131;71;72;74;71 22:05:52 INFO - PROCESS | 9127 | |4;audio-oscillator;97;99;151;96;96;97;142;96;97;149 22:05:52 INFO - PROCESS | 9127 | |5;imaging-gaussian-blur;110;110;110;110;110;109;110;109;109;109 22:05:52 INFO - PROCESS | 9127 | |6;imaging-darkroom;148;146;147;147;149;147;148;147;148;148 22:05:52 INFO - PROCESS | 9127 | |7;imaging-desaturate;96;96;97;101;96;98;98;96;98;97 22:05:52 INFO - PROCESS | 9127 | |8;json-parse-financial;59;57;59;58;58;59;59;62;55;57 22:05:52 INFO - PROCESS | 9127 | |9;json-stringify-tinderbox;67;68;68;69;69;69;68;68;69;68 22:05:52 INFO - PROCESS | 9127 | |10;stanford-crypto-aes;86;95;93;90;89;86;88;86;90;86 22:05:52 INFO - PROCESS | 9127 | |11;stanford-crypto-ccm;126;132;117;119;116;121;128;129;118;119 22:05:52 INFO - PROCESS | 9127 | |12;stanford-crypto-pbkdf2;144;154;167;151;159;142;160;151;157;144 22:05:52 INFO - PROCESS | 9127 | |13;stanford-crypto-sha256-iterative;72;68;71;70;69;72;68;71;68;70 22:05:52 INFO - PROCESS | 9127 | __end_tp_report 22:05:52 INFO - PROCESS | 9127 | __start_cc_report 22:05:52 INFO - PROCESS | 9127 | _x_x_mozilla_cycle_collect,734 22:05:52 INFO - PROCESS | 9127 | __end_cc_report 22:05:52 INFO - PROCESS | 9127 | __startTimestamp1451973952805__endTimestamp 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | ------- Summary: start ------- 22:05:52 INFO - PROCESS | 9127 | Number of tests: 14 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.95 (3.5%) stddev-sans-first:4.18 22:05:52 INFO - PROCESS | 9127 | Values: 112.0 109.0 112.0 111.0 111.0 123.0 112.0 113.0 110.0 110.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:152.50 stddev:16.01 (10.5%) stddev-sans-first:16.68 22:05:52 INFO - PROCESS | 9127 | Values: 153.0 127.0 152.0 160.0 125.0 156.0 150.0 129.0 167.0 126.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.68 (2.2%) stddev-sans-first:3.81 22:05:52 INFO - PROCESS | 9127 | Values: 162.0 163.0 162.0 162.0 166.0 163.0 162.0 164.0 174.0 164.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#3] audio-fft Cycles:10 Average:77.80 Median:72.00 stddev:18.72 (26.0%) stddev-sans-first:19.74 22:05:52 INFO - PROCESS | 9127 | Values: 72.0 71.0 71.0 73.0 72.0 131.0 71.0 72.0 74.0 71.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#4] audio-oscillator Cycles:10 Average:112.00 Median:96.50 stddev:24.50 (25.4%) stddev-sans-first:25.38 22:05:52 INFO - PROCESS | 9127 | Values: 97.0 99.0 151.0 96.0 96.0 97.0 142.0 96.0 97.0 149.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:05:52 INFO - PROCESS | 9127 | Values: 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 22:05:52 INFO - PROCESS | 9127 | Values: 148.0 146.0 147.0 147.0 149.0 147.0 148.0 147.0 148.0 148.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:97.00 stddev:1.57 (1.6%) stddev-sans-first:1.59 22:05:52 INFO - PROCESS | 9127 | Values: 96.0 96.0 97.0 101.0 96.0 98.0 98.0 96.0 98.0 97.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:59.00 stddev:1.83 (3.1%) stddev-sans-first:1.92 22:05:52 INFO - PROCESS | 9127 | Values: 59.0 57.0 59.0 58.0 58.0 59.0 59.0 62.0 55.0 57.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 22:05:52 INFO - PROCESS | 9127 | Values: 67.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 68.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:89.50 stddev:3.18 (3.6%) stddev-sans-first:3.19 22:05:52 INFO - PROCESS | 9127 | Values: 86.0 95.0 93.0 90.0 89.0 86.0 88.0 86.0 90.0 86.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:123.50 stddev:5.72 (4.6%) stddev-sans-first:5.93 22:05:52 INFO - PROCESS | 9127 | Values: 126.0 132.0 117.0 119.0 116.0 121.0 128.0 129.0 118.0 119.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:155.50 stddev:8.09 (5.2%) stddev-sans-first:7.91 22:05:52 INFO - PROCESS | 9127 | Values: 144.0 154.0 167.0 151.0 159.0 142.0 160.0 151.0 157.0 144.0 22:05:52 INFO - PROCESS | 9127 | 22:05:52 INFO - PROCESS | 9127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.60 (2.3%) stddev-sans-first:1.50 22:05:52 INFO - PROCESS | 9127 | Values: 72.0 68.0 71.0 70.0 69.0 72.0 68.0 71.0 68.0 70.0 22:05:52 INFO - PROCESS | 9127 | -------- Summary: end -------- 22:05:52 INFO - PROCESS | 9127 | 22:05:53 INFO - TEST-INFO | 9127: exit 0 22:05:53 INFO - TEST-OK | kraken | took 60083ms 22:05:53 INFO - TEST-START | v8_7 22:05:53 INFO - operating with platform_type : linux_ 22:05:53 INFO - Initialising browser for v8_7 test... 22:05:53 INFO - TEST-INFO | started process 9414 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQPrrI2/profile http://localhost:43698/getInfo.html) 22:05:58 INFO - PROCESS | 9414 | __metrics Screen width/height:1600/1200 22:05:58 INFO - PROCESS | 9414 | colorDepth:24 22:05:58 INFO - PROCESS | 9414 | Browser inner width/height: 1024/697 22:05:58 INFO - PROCESS | 9414 | __metrics 22:05:58 INFO - PROCESS | 9414 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:05:59 INFO - TEST-INFO | 9414: exit 0 22:05:59 INFO - Browser initialized. 22:05:59 INFO - Running cycle 1/1 for v8_7 test... 22:05:59 INFO - TEST-INFO | started process 9534 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQPrrI2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:06:11 INFO - PROCESS | 9534 | RSS: Main: 150577152 22:06:11 INFO - PROCESS | 9534 | 22:06:32 INFO - PROCESS | 9534 | Cycle 1(1): loaded http://localhost:43698/tests/v8_7/run.html (next: http://localhost:43698/tests/v8_7/run.html) 22:06:33 INFO - PROCESS | 9534 | RSS: Main: 145559552 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | __start_tp_report 22:06:33 INFO - PROCESS | 9534 | _x_x_mozilla_page_load 22:06:33 INFO - PROCESS | 9534 | _x_x_mozilla_page_load_details 22:06:33 INFO - PROCESS | 9534 | |i|pagename|runs| 22:06:33 INFO - PROCESS | 9534 | |0;Richards;165.97510373443984 22:06:33 INFO - PROCESS | 9534 | |1;DeltaBlue;190.62142584826535 22:06:33 INFO - PROCESS | 9534 | |2;Encrypt;280.1120448179272 22:06:33 INFO - PROCESS | 9534 | |3;Decrypt;5213.541666666667 22:06:33 INFO - PROCESS | 9534 | |4;RayTrace;1070.5882352941176 22:06:33 INFO - PROCESS | 9534 | |5;Earley;732.2604242867593 22:06:33 INFO - PROCESS | 9534 | |6;Boyer;12395.061728395061 22:06:33 INFO - PROCESS | 9534 | |7;RegExp;25200 22:06:33 INFO - PROCESS | 9534 | |8;Splay;571.1022272986864 22:06:33 INFO - PROCESS | 9534 | |9;NavierStokes;4830.917874396136 22:06:33 INFO - PROCESS | 9534 | __end_tp_report 22:06:33 INFO - PROCESS | 9534 | __startTimestamp1451973993048__endTimestamp 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | ------- Summary: start ------- 22:06:33 INFO - PROCESS | 9534 | Number of tests: 10 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 166.0 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#1] DeltaBlue Cycles:1 Average:190.62 Median:190.62 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 190.6 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 280.1 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 5213.5 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#4] RayTrace Cycles:1 Average:1070.59 Median:1070.59 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 1070.6 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#5] Earley Cycles:1 Average:732.26 Median:732.26 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 732.3 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 12395.1 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 25200.0 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#8] Splay Cycles:1 Average:571.10 Median:571.10 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 571.1 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - PROCESS | 9534 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:06:33 INFO - PROCESS | 9534 | Values: 4830.9 22:06:33 INFO - PROCESS | 9534 | -------- Summary: end -------- 22:06:33 INFO - PROCESS | 9534 | 22:06:33 INFO - TEST-INFO | 9534: exit 0 22:06:33 INFO - TEST-OK | v8_7 | took 40199ms 22:06:33 INFO - SUITE-END | took 1210s 22:06:34 INFO - Completed test suite (00:20:11) 22:06:34 INFO - Working with test: dromaeo_css 22:06:34 INFO - Generating results file: dromaeo_css 22:06:34 INFO - Working with test: kraken 22:06:34 INFO - Generating results file: kraken 22:06:34 INFO - javascript benchmark 22:06:34 INFO - Working with test: v8_7 22:06:34 INFO - Generating results file: v8_7 22:06:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 22:06:34 INFO - process_Request line: dromaeo_css 6807.80 graph.html#tests=[[72,63,43]] 22:06:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:34 INFO - process_Request line: kraken 1526.00 graph.html#tests=[[232,63,43]] 22:06:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:06:34 INFO - process_Request line: v8_7 21380.86 graph.html#tests=[[230,63,43]] 22:06:34 INFO - RETURN: dromaeo_css: 6807.80 22:06:34 INFO - RETURN: kraken: 1526.00 22:06:34 INFO - RETURN: v8_7: 21380.86 22:06:34 INFO - javascript benchmark 22:06:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3113.5174048022554, 3143.2613335866067, 3181.7295529879957, 3200.9359812803746, 3213.068210219036, 5121.487851214886, 5266.4733526647315, 5279.445658205886, 5286.656367336121, 5310.737271078206, 5133.383993920735, 5239.3712754469425, 5266.052110620087, 5298.20526920962, 5311.707856067915, 4480.372747815292, 4745.335653008581, 4928.67963582366, 4948.851534453954, 4985.576226020775, 4703.764811759415, 4844.685095468801, 4903.411590609114, 4919.089968355847, 4947.332110165117, 4678.859634210962, 4745.90508189836, 4803.039392121555, 4836.8149803298065, 4848.466668666461, 4758.167320718895, 4776.068666610013, 4787.976060119677, 4816.060868130681, 4833.516648335173, 4674.088552732219, 4758.738269395182, 4768.356271903318, 4783.708398732323, 4794.161021821167, 5091.719955402451, 5133.717645529495, 5156.3296771419855, 5174.068667639824, 5188.610854185951, 5705.115707065412, 5714.571407144439, 5725.599208055438, 5738.8278351649515, 5739.741711622987, 5623.915641265385, 5713.057345537981, 5754.712264386764, 5762.827115186551, 5774.293831531049, 5282.735863206824, 5322.175062865262, 5322.33470816148, 5326.201069839516, 5362.973185134049, 5816.709164541756, 5834.183214349994, 5856.677882716406, 5868.941310586925, 5875.764969401176, 5455.1271796512365, 5550.639208451437, 5583.357913839879, 5605.915911261334, 5627.380988091307, 5666.4050274721385, 5676.914846277309, 5678.432156784371, 5704.144378343199, 5746.224259724967, 5620.494155526022, 5640.717964101778, 5667.858303542444, 5692.0, 5717.22817419643, 5515.696636684941, 5616.354119276254, 5629.211910332557, 5680.0, 5726.226959360516, 4364.869053928387, 4388.078503514298, 4415.139047885696, 4429.734215946989, 4436.844710435119, 3909.9609003910164, 3932.410138479194, 3941.9750864775365, 3945.546262179886, 3997.780122093313, 5211.1922651989, 5291.682499050069, 5336.813211537655, 5401.189821526724, 5438.075527160392, 5607.467290607386, 5669.0, 5690.5447564194765, 5713.200151978726, 5732.885342293131, 5176.50823171798, 5356.196570514454, 5377.5160235578205, 5377.623566350318, 5420.376656684453, 4840.491748366441, 4886.29148773433, 4894.975525122351, 4931.457539670633, 4945.604351651859, 5962.1056841473255, 5986.102084687332, 5989.341172471025, 5989.460948514655, 6008.309044459943, 5512.3385193777, 5614.04561224601, 5723.885522289447, 5726.0, 5745.2818397700285, 5898.085796701518, 5921.703914804329, 5956.642601443928, 5989.431004054608, 5993.520518358608, 5596.580256480862, 5606.523445507014, 5607.327120745536, 5608.495235428831, 5617.887642247214, 5563.666180029211, 5662.065759149694, 5669.4047125051275, 5691.032524470767, 5711.143328500758, 5604.355499117653, 5604.607677462538, 5614.354349249726, 5622.718864056699, 5651.83044508649, 5554.055810512142, 5573.359063707726, 5580.720963951705, 5586.692731899784, 5589.217509548747, 5314.62797604164, 5410.1343784994215, 5417.783288668409, 5428.7557059931605, 5491.121420572849, 5461.9453805461435, 5490.176473529003, 5630.014747419267, 5681.659100453986, 5729.742161602655, 5410.404855465817, 5430.13117901134, 5433.347998240237, 5441.483059109379, 5482.28730265079], "unit": "score", "name": "dojo.html", "value": 5238.70054113723}, {"lowerIsBetter": false, "replicates": [526.9881826892366, 528.6748649580506, 531.2191079113702, 554.3458718711921, 563.6251892491493, 34396.656033439656, 35767.0, 35795.82102089486, 35796.821015894915, 35818.64181358185, 39388.0, 39726.801365993204, 39764.20471590574, 39769.403458948065, 39885.60114398855, 8335.374846886492, 8512.1487851215, 8518.40371174015, 8523.232909038185, 8543.0, 8314.792130196733, 8419.0, 8436.409451338379, 8623.267022303111, 8688.56557172142, 8540.188682075193, 8600.784980375478, 8607.225349718556, 8618.0, 8672.60973256205, 8545.401821872472, 8554.443961142506, 8582.313414926854, 8595.0, 8603.827923441528, 8338.83322333556, 8565.486070835708, 8573.356998225157, 8588.570571471464, 8596.097409772008, 38417.0, 38921.61078389208, 38934.22131557381, 39146.412803807965, 39184.02039948996, 3128.0, 3141.4502462069277, 3415.9658403415897, 3510.438329867209, 3910.960890391088, 28774.568381474295, 29172.854135729398, 29244.415111697646, 29446.263843404085, 30121.0, 3522.6829585337186, 3531.1525233943926, 3533.2403533240476, 3562.340966921128, 3577.123604716835, 253551.0, 257096.0, 257521.0, 257644.0, 259028.9999999981, 52636.73681631567, 53523.46476535185, 58789.41210587925, 60130.39869601248, 60265.69867150636, 53596.464035359924, 54113.45886541163, 54134.18798718022, 54183.03986561475, 54384.728076359366, 14865.479708210161, 14929.850701493064, 15061.472848450252, 15084.396624135132, 15139.0, 11403.258788178742, 11423.428828558539, 11539.307641541534, 11806.409679516162, 11856.940715296369, 19576.3148289812, 19863.30478433248, 19879.60240795176, 19890.801091989186, 19898.403047908585, 7872.606369681493, 8040.557769322626, 8094.109647938722, 8106.918930810734, 8138.552379619177, 865.9870101948476, 880.1550511508896, 959.5058544849409, 1090.7612521939163, 1097.3964319624174, 27399.86300068527, 27733.722662773114, 27868.860655696997, 28055.71944280531, 28213.294667633472, 970.684527528556, 994.6966175316597, 996.6113215845826, 1025.108155904368, 1036.9533370998324, 14328.355224014944, 14344.856551434352, 14410.279486025656, 14469.421223151166, 14713.55859324222, 303228.0, 305987.0, 306324.0, 306639.0, 307122.0, 49470.0, 49800.0, 50124.240681949, 50137.74931125394, 50323.0, 1279.923204607708, 1280.801475771257, 1281.6923938254752, 1290.2903403128241, 1295.4235365262368, 26427.207183784518, 27126.0, 27281.59077613798, 27326.863365683046, 27570.448591028467, 40021.39967900426, 40024.799876000434, 40075.59924400835, 40246.1950760989, 40293.19413611653, 268065.0, 271709.0, 272330.0, 272955.0, 273372.0, 31615.36769264648, 42081.57918420899, 42206.0, 43054.78472607617, 43150.35274470948, 44181.55818441774, 45597.54402456066, 46386.30420543762, 46432.0, 46572.30141547812, 32875.17812054718, 33302.0, 33802.154946125556, 34042.0, 34262.0, 39342.803285983384, 40128.0, 40246.0, 42874.356884646135, 44762.0, 35893.64106358903, 35951.640483595875, 36371.27257454889, 36444.81777591201, 36666.0, 36525.64783163063, 38331.0, 38466.42300365441, 39070.67899228484, 39398.80300598479, 29353.559696604996, 29603.259918502208, 29854.70145298519, 30195.0, 30286.54570181405], "unit": "score", "name": "ext.html", "value": 18267.20768107263}, {"lowerIsBetter": false, "replicates": [358.5661349766782, 359.5667220998697, 362.3477740067877, 363.50018724254153, 366.3387585408337, 16134.0, 16738.665226695473, 17396.913015434937, 17614.73577896331, 17970.281188752433, 9925.255605829556, 9995.15041221497, 10218.233632477575, 10282.845757313627, 10305.278630495868, 4853.563179313852, 4867.0, 4975.179095449246, 4981.103401387749, 4982.975085124569, 5266.289050978126, 5328.813491527797, 5331.57347412208, 5333.599980001496, 5333.919991200135, 4822.541858523452, 5053.444121146671, 5055.873603159914, 5283.762230699628, 5293.444188360225, 4967.751612419364, 4979.053979743837, 4988.052270068693, 4989.525995030466, 5446.809361672323, 5254.579633629301, 5299.1786273127345, 5303.496167864047, 5321.73391330432, 5324.361076670824, 10691.518881650345, 10995.0, 16334.34662613494, 19971.700424493643, 20001.699974500396, 1990.9004549772453, 1997.1911375892787, 2077.4390914453015, 2121.3847984084596, 2150.0109949423127, 8485.83028339436, 8677.652893884237, 9014.278857691435, 9056.275497960214, 9178.67874624385, 1615.5557221764109, 1636.0919689572283, 1659.0875018739646, 1663.1601041474098, 1687.9578010549712, 58011.0, 59457.7027114866, 59535.534834887556, 59736.0, 60358.39641603616, 9953.751156221007, 10141.645042423479, 10212.744681383025, 10227.0, 10270.845937310947, 13239.404226809816, 13302.46790128384, 13321.0, 13326.800097998537, 13347.599572012856, 7365.963170184222, 7397.926020739831, 7458.179600243969, 7549.6225188740345, 7625.351845093118, 6941.444684425234, 7004.824879378057, 7033.6483175841, 7064.682089305994, 7068.293170682993, 4215.768132752667, 4229.851955181615, 4312.353147027909, 4347.130573885235, 4411.558844115627, 1833.367488216563, 1856.7214917762444, 1885.1893685715274, 1896.2415033986515, 1897.7627796525435, 871.7210492642294, 890.4034297021011, 1031.6131450705984, 1040.6929955663097, 1057.709129989259, 10758.0, 13984.021118521607, 15953.601159970862, 16165.515034548982, 16447.342106315853, 408.78538767147484, 417.20730611837143, 420.2100051902465, 423.8050496771458, 438.09533313707095, 5368.5436737876935, 5394.91907621386, 5597.80407685729, 5606.299212598426, 5691.686957217393, 515581.0, 523222.0, 528304.0, 534608.0, 541605.0, 82230.58884705658, 82782.58608706918, 86898.0, 87006.12993870107, 88616.556917215, 452.60171049476253, 455.09890416974577, 457.62932025059143, 468.8405941979743, 469.9459562150328, 10575.788484230427, 10742.194335424718, 10749.14006879432, 14885.776713349525, 15499.868266032981, 34312.0, 34852.0, 35912.281754364245, 36000.639993599725, 36367.81816091009, 47132.29301560411, 47196.0, 47651.0, 47942.0, 48121.518784811706, 9023.278137749096, 9395.2953528487, 9482.38364506305, 9522.47626380528, 9816.312858099864, 17746.11269436549, 17880.55298617493, 17953.102344882966, 18061.909690451463, 18533.53666158357, 13668.726625467634, 13986.790198146833, 14364.85635143677, 14377.28113594337, 14398.42406303736, 13704.177749335071, 14091.436342546593, 14400.279986000449, 14582.0, 14784.260786960394, 14307.427702892184, 14814.77777833355, 15001.549953501413, 15255.847441525886, 15276.923615381851, 9113.544322783702, 9282.814343713222, 9598.856017159887, 10053.648122315684, 10057.798844023226, 14593.270336482921, 14896.180710061051, 15093.094414335175, 15180.165090920105, 15294.388224470897], "unit": "score", "name": "jquery.html", "value": 8048.806886346695}, {"lowerIsBetter": false, "replicates": [1348.9123206991542, 1357.3009899901551, 1494.2230040379004, 1753.1409609291452, 1794.999999999999, 6279.968600156993, 6320.115183874262, 7630.809229769252, 7664.92335076649, 7670.5014174078715, 7171.175314838795, 7210.4952653314285, 7294.927050729491, 7329.413646908248, 7358.484906056578, 2126.8298536117113, 2164.9242276520326, 2176.6299729046023, 2177.477405422703, 2177.858439201447, 2126.6597344424895, 2134.583756167548, 2245.5059886824874, 2254.5265494246228, 2263.094762095167, 2201.03154611971, 2201.1305534313938, 2235.005422586941, 2239.473723674935, 2243.05791567542, 2184.726909136358, 2188.1684959715367, 2201.108551036825, 2202.2072054060527, 2205.37146913129, 2180.6292930201903, 2223.088533701191, 2225.0765932138142, 2228.576570451609, 2229.4203507088114, 7527.736529221451, 7580.128285247212, 7580.469367144302, 7593.08882934046, 7604.239576042407, 4432.468103827529, 4491.326301054835, 4494.438195225597, 4503.842365517191, 4511.368408422823, 2887.3070463088916, 2904.143277733074, 2917.0811194473886, 2933.7946343755943, 2966.362232120083, 960.6493629825063, 997.5012493753123, 1013.716159475348, 1020.7090979071004, 1026.743314171457, 10051.346662466989, 10214.948925255401, 10216.74458138545, 10245.84631230532, 10258.7435314117, 3926.54844692864, 3969.1069509360163, 3982.761034337949, 4021.5777343378522, 4052.0477687743355, 8671.6531338747, 8765.43024703405, 8777.42946708462, 8799.25206357454, 8814.118588141262, 4467.776611169428, 4502.482214545369, 4515.774211289422, 4522.954770452254, 4537.047220083819, 4087.1212689271947, 4092.7339722917914, 4111.9177616447505, 4153.937690934638, 4168.895777605584, 3355.345707586997, 3424.6917777400154, 3425.2806910549066, 3455.36075825973, 3480.3735327641266, 1025.676911772804, 1034.6533911139702, 1035.9015893490107, 1037.6108959140322, 1038.43924280889, 1311.7376524694907, 1318.821959035518, 1324.2319454716242, 1327.6548097494722, 1342.8589998050259, 7156.570605763671, 7223.494355395072, 7310.268973102648, 7332.376747976482, 7336.449766267551, 483.5092381233051, 483.84033269021137, 490.14959046055066, 491.5944345914635, 492.1264755059797, 5634.211210430543, 5643.097104463266, 5664.603477756517, 5673.914891276634, 5698.544116470673, 8760.649574017096, 8848.0, 8908.0, 8956.507392093366, 8986.460812351279, 8822.0, 8822.86765698515, 8836.248918841971, 8886.777830554158, 8892.244159246407, 6600.768973085919, 6693.899591506131, 6718.22740384862, 6747.696353663999, 6784.626845523544, 7032.050673159058, 7089.326513981164, 7114.430845532242, 7120.572765634079, 7133.179684336368, 8015.47899386538, 8195.016598008038, 8224.62989165501, 8294.834103317778, 8390.286825619647, 8248.793780155544, 8365.456245344034, 8372.45579037385, 8382.37132215074, 8412.453190542596, 5758.366579676316, 5841.094630332305, 6339.429451349401, 6345.3654634538025, 6414.262359828493, 7223.674934628059, 7223.8555228896175, 7224.313690199423, 7247.166575843846, 7282.745103921337, 6441.854698735433, 6960.721571137098, 6982.1272340957385, 7036.190838053484, 7040.929590704028, 6833.863322733617, 6851.862962740817, 6874.793756187322, 6922.134733158356, 6938.61227754441, 6813.69338379784, 6858.6227757471825, 6893.965530172317, 6926.792196234121, 6930.203026652, 6310.905336420049, 6336.651484168415, 6338.239411270677, 6372.713227904848, 6377.8724425512155, 6477.157969464128, 6485.0, 6485.935140648533, 6536.117624120873, 6551.639659818565], "unit": "score", "name": "mootools.html", "value": 4245.0005512635835}, {"lowerIsBetter": false, "replicates": [333.8414253229716, 336.81306874684543, 338.6156712131733, 344.546920799149, 344.89825501477077, 6173.888700033997, 6203.255609326881, 6235.158253635758, 6251.0, 6293.0, 6163.075538669202, 6182.0, 6199.132121502993, 6214.03682429223, 6242.968785156079, 4698.295255711637, 4711.858644240661, 4735.266033764772, 4756.28655701644, 4770.0936822003705, 4742.454617718955, 4753.215719406311, 4755.286706993961, 4765.26138448541, 4769.5707386335225, 4519.079391258719, 4553.817847286121, 4617.6536759742985, 4630.236011058171, 4676.3453116563705, 4590.242609969351, 4597.908041839161, 4601.033782905593, 4607.884802879921, 4619.16854966106, 4007.338789099795, 4036.414719865603, 4074.9796251018556, 4078.163976384834, 4083.673306135502, 5900.1739756434135, 5922.31893332268, 5936.821895343147, 5945.137954996501, 5946.256717910262, 5279.076161671692, 5392.730363481849, 5415.350157981067, 5455.754491047913, 5463.31708536433, 6380.1705778249, 6421.839454013687, 6427.453666438359, 6438.066480360369, 6529.869402611921, 4488.192125417424, 4497.527759585262, 4502.774861256957, 4508.188526065307, 4508.504064552896, 6670.4997125215805, 6850.349216824394, 6865.828354291183, 6870.0, 6884.896726549106, 4504.977475112603, 4583.220852455091, 4592.816287348535, 4597.540245975376, 4613.0312634347165, 4643.605293550018, 4647.930281045787, 4657.4876763555985, 4662.976685116552, 4675.368825208621, 5428.70142142186, 5444.455554444603, 5450.91823622646, 5455.509004189642, 5459.890802183934, 6531.052997315458, 6630.502712296597, 6631.86736265272, 6643.036759669821, 6646.368594983469, 1634.5014770494874, 1658.29522452957, 1661.5846038490376, 1662.9523400258001, 1665.2173478465102, 1069.994650026745, 1090.4983707494482, 1093.4478088565384, 1103.906167975715, 1105.5080489182237, 6328.557001009885, 6340.841478963062, 6343.9682801585695, 6361.713722882481, 6370.968145159337, 6768.7292508299115, 6782.152230971129, 6813.693383797741, 6817.045613614098, 6831.897521537181, 6215.81352559424, 6305.873882522324, 6322.525810564226, 6329.715162817684, 6384.648844313514, 3705.40713485841, 3720.311742327678, 3725.813709314578, 3732.6080761520193, 3743.47591337213, 7236.059312289474, 7243.963780181065, 7245.89131163033, 7249.927500724925, 7251.746188883364, 6826.624535650587, 6991.23096459389, 7002.614856182857, 7042.154941407064, 7044.15470143586, 7209.062821833233, 7222.241664625139, 7233.914912763023, 7234.0, 7241.275872412716, 6819.556728812611, 6829.453643708591, 6864.519483636098, 6867.381935625618, 6874.140732408449, 6650.334966503311, 6775.830604234933, 6777.1189745332795, 6778.8644227116165, 6781.050652908695, 7168.820779480555, 7182.784516464514, 7183.461240407095, 7222.855542889218, 7233.1681856587165, 4555.20283950314, 4566.109608626286, 4585.358049872953, 4593.54064593538, 4594.747288899009, 6802.795916122524, 6803.387695107464, 6880.346367095118, 6908.965455172692, 6919.065926099912, 6635.834104147435, 6640.203175618956, 6678.49911256648, 6678.632675202911, 6683.498737594603, 6566.8358291043105, 6660.6336651484635, 6679.298673639198, 6679.9332006679315, 6691.5650482718465, 6528.771492997722, 6558.081868538313, 6558.245801732862, 6560.147180866456, 6568.573042752206, 6702.128723265944, 6708.758879607289, 6710.362515561014, 6716.529842910949, 6716.966415167893, 6402.103705481143, 6550.705218265094, 6551.574147680385, 6564.934350656624, 6572.507061970276], "unit": "score", "name": "prototype.html", "value": 4962.710042214003}, {"lowerIsBetter": false, "replicates": [802.4062193976457, 842.7850898021004, 857.9184977427144, 861.5519929636589, 889.4485419040196, 13371.465141394345, 13640.31798410078, 13674.247916364597, 13683.24742139182, 13693.246871422069, 12003.159778815487, 12004.279743215413, 12012.099092568049, 12087.516499340038, 12103.394830258496, 667.2960027171332, 668.582136164897, 786.1666633368619, 796.3072127249287, 823.3289868756943, 806.4153488720689, 816.3061397811872, 818.5088946632033, 824.2664029014182, 825.2861274997144, 860.2859626510013, 867.0, 867.7743786615493, 869.3349587565517, 869.586946200556, 852.6333676519095, 854.9102344253857, 855.2132038524572, 856.2251162697769, 863.5034854958393, 630.8107567729709, 633.7528363938068, 634.5431289471574, 638.8370965403839, 643.9066335381343, 13347.466101355934, 13499.527516536973, 13517.121387109806, 13608.659783505393, 13623.386947587283, 12013.87986120145, 12161.087918406067, 12186.75626487474, 12436.19164754288, 12981.610551683465, 9477.194438472738, 9539.332246742732, 9711.125998660154, 9948.761528655994, 10016.79966400668, 3567.500549923013, 3608.9097772555633, 3635.2184280379847, 3672.559292884871, 3759.8684046058256, 47021.76489117533, 47068.29397559039, 47537.0, 47655.5234447658, 47834.28248576309, 9645.37305075168, 9744.902550974399, 9902.801943961225, 10003.199744020461, 10244.282900197064, 18596.163172657263, 18698.626027479648, 18798.154083066296, 18807.717884231748, 18926.716099258523, 7268.927310726825, 7340.889886651705, 7352.77941661751, 7387.7783666490095, 7504.887426688604, 4101.077257617012, 4228.450301460791, 4240.469941257343, 4241.215375155606, 4255.255330317182, 3107.2697915989725, 3145.040762567439, 3145.8741650334186, 3148.8268145251773, 3155.6213254409618, 560.3723829311198, 565.9236003139523, 580.4717706886713, 582.2837909371412, 588.0796553393925, 471.1613328275675, 472.3363674037982, 501.36076502459656, 504.6114491841335, 533.7651433369305, 7773.144954055162, 7882.330001949898, 8070.878936815952, 8345.457545259538, 8413.70552030676, 496.5580633236423, 517.76959253132, 527.8179028235253, 536.9221462887859, 590.8847774683982, 3888.8833334999995, 3901.317269477887, 4030.173814368106, 4060.309747342959, 4068.572799856032, 49761.75119124381, 50511.49488505068, 50512.49487505152, 50522.49477505252, 50637.0, 45033.54966450359, 45576.772116139204, 45758.54241457543, 46121.53878461172, 46321.76839115783, 43544.564554354685, 44227.11545769066, 44412.111757764666, 45137.32294015592, 45541.54458455373, 8296.83406331858, 8376.832463350576, 8380.53907035119, 8429.747107586782, 8543.91456085456, 32895.83552082224, 33570.832145839115, 33722.66277337195, 34195.82902085473, 34348.14129646779, 39362.0, 42249.0, 42565.36151957661, 43467.56532434762, 43909.12181756411, 10011.39931604077, 10134.189264858942, 10781.730456738644, 11226.0, 11447.370394628375, 11860.525578976743, 12057.095717821023, 12114.939425302817, 12398.876011239772, 12735.172213806072, 11240.55037798479, 11361.147913906325, 11461.4269286537, 11523.654290371302, 11793.941030295136, 11157.888421115686, 11504.424778760862, 11511.30932144074, 11935.104867134825, 11980.520779169085, 10710.250282480152, 11047.226694131334, 11244.55021799119, 11416.257943233662, 11527.250728702607, 9684.761125197161, 9816.26378021637, 9894.257930655374, 9998.600055997678, 10217.0, 8861.202491775772, 8922.509261990654, 9211.953940230524, 9774.12032917041, 9861.556229969812], "unit": "score", "name": "yui.html", "value": 6134.462432382399}], "name": "dromaeo_css", "value": 6807.795180194297}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 111.0, 111.0, 123.0, 112.0, 113.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [153.0, 127.0, 152.0, 160.0, 125.0, 156.0, 150.0, 129.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 166.0, 163.0, 162.0, 164.0, 174.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 73.0, 72.0, 131.0, 71.0, 72.0, 74.0, 71.0], "unit": "score", "name": "audio-fft", "value": 77.8}, {"lowerIsBetter": true, "replicates": [97.0, 99.0, 151.0, 96.0, 96.0, 97.0, 142.0, 96.0, 97.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 112.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 101.0, 96.0, 98.0, 98.0, 96.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.3}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 59.0, 58.0, 58.0, 59.0, 59.0, 62.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [86.0, 95.0, 93.0, 90.0, 89.0, 86.0, 88.0, 86.0, 90.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [126.0, 132.0, 117.0, 119.0, 116.0, 121.0, 128.0, 129.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.5}, {"lowerIsBetter": true, "replicates": [144.0, 154.0, 167.0, 151.0, 159.0, 142.0, 160.0, 151.0, 157.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.9}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 71.0, 70.0, 69.0, 72.0, 68.0, 71.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1526.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [190.62142584826535], "unit": "score", "name": "DeltaBlue", "value": 346.8550280000001}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1070.5882352941176], "unit": "score", "name": "RayTrace", "value": 691.1985164835162}, {"lowerIsBetter": false, "replicates": [732.2604242867593], "unit": "score", "name": "Earley", "value": 910.1447762237763}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [25200.0], "unit": "score", "name": "RegExp", "value": 36.150198412698415}, {"lowerIsBetter": false, "replicates": [571.1022272986864], "unit": "score", "name": "Splay", "value": 142.690741}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21380.856949882913}]} 22:06:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21380.86"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1526.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6807.80"}}} 22:06:34 INFO - Return code: 0 22:06:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:06:34 INFO - # TBPL SUCCESS # 22:06:34 INFO - Running post-action listener: _resource_record_post_action 22:06:34 INFO - Running post-run listener: _resource_record_post_run 22:06:35 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 557883392; Read time: 0; Write time: 548160 22:06:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237711360; Read time: 0; Write time: 295992 22:06:35 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 319295488; Read time: 0; Write time: 252124 22:06:35 INFO - Running post-run listener: _upload_blobber_files 22:06:35 INFO - Blob upload gear active. 22:06:35 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:06:35 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:06:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:06:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:06:35 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:36 INFO - (blobuploader) - INFO - Done attempting. 22:06:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:06:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:06:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:37 INFO - (blobuploader) - INFO - Done attempting. 22:06:37 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:37 INFO - Return code: 0 22:06:37 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:06:37 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fa3440f6f1989db8678c747e3916b16be9b45f46b3a9eb0edcdfaec06a1eb4706cfa573e20e15f96ad31ea3cc9e3990632777418b6bfb26cfa674bb58707da6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e598bbfad600e95f02fb44bda703d40d82d116ed6968f5d9dcd76322f5681dc5063e935b77ad7f3be13f155805f40393ea4c86a62a7e5ca39ff8fffbcc0d1d15"} 22:06:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:06:37 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:06:37 INFO - Contents: 22:06:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fa3440f6f1989db8678c747e3916b16be9b45f46b3a9eb0edcdfaec06a1eb4706cfa573e20e15f96ad31ea3cc9e3990632777418b6bfb26cfa674bb58707da6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e598bbfad600e95f02fb44bda703d40d82d116ed6968f5d9dcd76322f5681dc5063e935b77ad7f3be13f155805f40393ea4c86a62a7e5ca39ff8fffbcc0d1d15"} 22:06:37 INFO - Copying logs to upload dir... 22:06:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.233054 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-04 22:06:37.037093) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 22:06:37.040396) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fa3440f6f1989db8678c747e3916b16be9b45f46b3a9eb0edcdfaec06a1eb4706cfa573e20e15f96ad31ea3cc9e3990632777418b6bfb26cfa674bb58707da6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e598bbfad600e95f02fb44bda703d40d82d116ed6968f5d9dcd76322f5681dc5063e935b77ad7f3be13f155805f40393ea4c86a62a7e5ca39ff8fffbcc0d1d15"} build_url:https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/YN3-UpiwSTmELrmyxIwN7g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9fa3440f6f1989db8678c747e3916b16be9b45f46b3a9eb0edcdfaec06a1eb4706cfa573e20e15f96ad31ea3cc9e3990632777418b6bfb26cfa674bb58707da6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e598bbfad600e95f02fb44bda703d40d82d116ed6968f5d9dcd76322f5681dc5063e935b77ad7f3be13f155805f40393ea4c86a62a7e5ca39ff8fffbcc0d1d15"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 22:06:37.065022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:06:37.065336) ========= 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=eca2ab57546de7b41f256b19000001ef-1451969440.98032-844472021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004530 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:06:37.148897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 22:06:37.149233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 22:06:37.149789) ========= ========= Total master_lag: 0.24 =========