builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1452827063.03 results: success (0) buildid: 20160114173018 builduid: 2543b59e8e23400a839328df44d9ec00 revision: 0d39fb92a77487fe494da2b3721815aa50cec625 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.025495) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.026023) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.026329) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006368 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.049545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.049823) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.062975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.063252) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.125791) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.126075) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.126452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.126748) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 19:04:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.9M=0s 2016-01-14 19:04:24 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158213 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.340633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.340945) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014889 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.367065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:23.367364) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0d39fb92a77487fe494da2b3721815aa50cec625 --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/fx-team --rev 0d39fb92a77487fe494da2b3721815aa50cec625 --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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 19:04:24,235 truncating revision to first 12 chars 2016-01-14 19:04:24,236 Setting DEBUG logging. 2016-01-14 19:04:24,236 attempt 1/10 2016-01-14 19:04:24,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0d39fb92a774?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 19:04:24,512 unpacking tar archive at: fx-team-0d39fb92a774/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:24.001905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:24.002213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:24.010280) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:24.010667) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:24.011142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 19:04:24.011470) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:24 INFO - MultiFileLogger online at 20160114 19:04:24 in /builds/slave/test-pgo 19:04:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:04:24 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:04:24 INFO - {'append_to_log': False, 19:04:24 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:04:24 INFO - 'blob_upload_branch': 'Fx-Team', 19:04:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:04:24 INFO - 'branch': 'Fx-Team', 19:04:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:24 INFO - 'config_files': ('talos/linux_config.py',), 19:04:24 INFO - 'default_actions': ('clobber', 19:04:24 INFO - 'read-buildbot-config', 19:04:24 INFO - 'download-and-extract', 19:04:24 INFO - 'populate-webroot', 19:04:24 INFO - 'create-virtualenv', 19:04:24 INFO - 'install', 19:04:24 INFO - 'run-tests'), 19:04:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:24 INFO - 'download_minidump_stackwalk': True, 19:04:24 INFO - 'download_symbols': 'ondemand', 19:04:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:24 INFO - 'installer_path': 'installer.exe', 19:04:24 INFO - 'log_level': 'info', 19:04:24 INFO - 'log_name': 'talos', 19:04:24 INFO - 'log_to_console': True, 19:04:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:24 INFO - 'opt_config_files': (), 19:04:24 INFO - 'pip_index': False, 19:04:24 INFO - 'sps_profile': False, 19:04:24 INFO - 'sps_profile_interval': 0, 19:04:24 INFO - 'suite': 'dromaeojs-e10s', 19:04:24 INFO - 'system_bits': '32', 19:04:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:24 INFO - 'title': 'talos-linux64-ix-031', 19:04:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:24 INFO - 'use_talos_json': True, 19:04:24 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:04:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:24 INFO - 'work_dir': 'build'} 19:04:24 INFO - ##### 19:04:24 INFO - ##### Running clobber step. 19:04:24 INFO - ##### 19:04:24 INFO - Running pre-action listener: _resource_record_pre_action 19:04:24 INFO - Running main action method: clobber 19:04:24 INFO - rmtree: /builds/slave/test-pgo/build 19:04:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:04:25 INFO - Running post-action listener: _resource_record_post_action 19:04:25 INFO - ##### 19:04:25 INFO - ##### Running read-buildbot-config step. 19:04:25 INFO - ##### 19:04:25 INFO - Running pre-action listener: _resource_record_pre_action 19:04:25 INFO - Running main action method: read_buildbot_config 19:04:25 INFO - Using buildbot properties: 19:04:25 INFO - { 19:04:25 INFO - "project": "", 19:04:25 INFO - "product": "firefox", 19:04:25 INFO - "script_repo_revision": "production", 19:04:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:04:25 INFO - "repository": "", 19:04:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:04:25 INFO - "buildid": "20160114173018", 19:04:25 INFO - "pgo_build": "True", 19:04:25 INFO - "basedir": "/builds/slave/test-pgo", 19:04:25 INFO - "buildnumber": 204, 19:04:25 INFO - "slavename": "talos-linux64-ix-031", 19:04:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:04:25 INFO - "platform": "ubuntu64_hw", 19:04:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:04:25 INFO - "branch": "fx-team", 19:04:25 INFO - "repo_path": "integration/fx-team", 19:04:25 INFO - "revision": "0d39fb92a77487fe494da2b3721815aa50cec625", 19:04:25 INFO - "stage_platform": "linux64-pgo", 19:04:25 INFO - "builduid": "2543b59e8e23400a839328df44d9ec00", 19:04:25 INFO - "slavebuilddir": "test" 19:04:25 INFO - } 19:04:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:04:25 INFO - Running post-action listener: _resource_record_post_action 19:04:25 INFO - ##### 19:04:25 INFO - ##### Running download-and-extract step. 19:04:25 INFO - ##### 19:04:25 INFO - Running pre-action listener: _resource_record_pre_action 19:04:25 INFO - Running main action method: download_and_extract 19:04:25 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:25 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json 19:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json 19:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:04:26 INFO - Downloaded 1448 bytes. 19:04:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:04:26 INFO - Using the following test package requirements: 19:04:26 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:26 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:04:26 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:04:26 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'jsshell-linux-x86_64.zip'], 19:04:26 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:04:26 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:26 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:04:26 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:04:26 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:04:26 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:26 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:26 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:04:26 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:04: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')]} 19:04:26 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:31 INFO - Downloaded 22439258 bytes. 19:04:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:04:32 INFO - Return code: 0 19:04:32 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 19:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:32 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:37 INFO - Downloaded 22439258 bytes. 19:04:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:04:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:04:38 INFO - Return code: 0 19:04:38 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')]} 19:04:38 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:04:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:04:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:41 INFO - Downloaded 11132144 bytes. 19:04:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:04:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:04:41 INFO - Return code: 0 19:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:41 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/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 19:04:45 INFO - Downloaded 55954802 bytes. 19:04:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:04:45 INFO - mkdir: /builds/slave/test-pgo/properties 19:04:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:04:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:04:45 INFO - Contents: 19:04:45 INFO - build_url:https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:04:45 INFO - Running post-action listener: _resource_record_post_action 19:04:45 INFO - Running post-action listener: set_extra_try_arguments 19:04:45 INFO - ##### 19:04:45 INFO - ##### Running populate-webroot step. 19:04:45 INFO - ##### 19:04:45 INFO - Running pre-action listener: _resource_record_pre_action 19:04:45 INFO - Running main action method: populate_webroot 19:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:04:45 INFO - '--tppagecycles', 19:04:45 INFO - '7'], 19:04:45 INFO - 'tests': ['tsvgm']}}, 19:04:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:04:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:04:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:04:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:04:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:04:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'tests': ['damp', 'tps']}, 19:04:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['damp', 'tps']}, 19:04:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:04:45 INFO - 'other': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'other_l64': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'other_nol64': {'tests': ['a11yr', 19:04:45 INFO - 'ts_paint', 19:04:45 INFO - 'tpaint', 19:04:45 INFO - 'sessionrestore', 19:04:45 INFO - 'sessionrestore_no_auto_restore']}, 19:04:45 INFO - 'svgr': {'tests': ['tsvgx', 19:04:45 INFO - 'tsvgr_opacity', 19:04:45 INFO - 'tart', 19:04:45 INFO - 'tscrollx', 19:04:45 INFO - 'cart']}, 19:04:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['tsvgx', 19:04:45 INFO - 'tsvgr_opacity', 19:04:45 INFO - 'tart', 19:04:45 INFO - 'tscrollx', 19:04:45 INFO - 'cart']}, 19:04:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'tests': ['tp5o']}, 19:04:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'talos_options': ['--e10s'], 19:04:45 INFO - 'tests': ['tp5o']}, 19:04:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'talos_options': ['--xperf_path', 19:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:45 INFO - 'tests': ['tp5n']}, 19:04:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:04:45 INFO - 'talos_options': ['--e10s', 19:04:45 INFO - '--xperf_path', 19:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:04:45 INFO - 'tests': ['tp5n']}}, 19:04:45 INFO - 'talos.zip': {'path': '', 19:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:04:45 INFO - Running post-action listener: _resource_record_post_action 19:04:45 INFO - ##### 19:04:45 INFO - ##### Running create-virtualenv step. 19:04:45 INFO - ##### 19:04:45 INFO - Running pre-action listener: _resource_record_pre_action 19:04:45 INFO - Running main action method: create_virtualenv 19:04:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:04:45 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 19:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:04:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:04:45 INFO - Using real prefix '/usr' 19:04:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:04:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:47 INFO - Installing pip.................done. 19:04:47 INFO - Return code: 0 19:04:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:04: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')]} 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:04: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 pip>=1.5 19:04:48 INFO - Using env: {'DISPLAY': ':0', 19:04:48 INFO - 'HOME': '/home/cltbld', 19:04:48 INFO - 'LANG': 'en_US.UTF-8', 19:04:48 INFO - 'LANGUAGE': 'en_US:en', 19:04:48 INFO - 'LOGNAME': 'cltbld', 19:04:48 INFO - 'MAIL': '/var/mail/cltbld', 19:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:48 INFO - 'MOZ_NO_REMOTE': '1', 19:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:48 INFO - 'NO_EM_RESTART': '1', 19:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:48 INFO - 'SHELL': '/bin/bash', 19:04:48 INFO - 'SHLVL': '1', 19:04:48 INFO - 'TERM': 'linux', 19:04:48 INFO - 'TMOUT': '86400', 19:04:48 INFO - 'USER': 'cltbld', 19:04:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:48 INFO - '_': '/tools/buildbot/bin/python'} 19:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:48 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 19:04:48 INFO - Cleaning up... 19:04:48 INFO - Return code: 0 19:04:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:04: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')]} 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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', '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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:04: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 psutil>=0.7.1 19:04:48 INFO - Using env: {'DISPLAY': ':0', 19:04:48 INFO - 'HOME': '/home/cltbld', 19:04:48 INFO - 'LANG': 'en_US.UTF-8', 19:04:48 INFO - 'LANGUAGE': 'en_US:en', 19:04:48 INFO - 'LOGNAME': 'cltbld', 19:04:48 INFO - 'MAIL': '/var/mail/cltbld', 19:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:48 INFO - 'MOZ_NO_REMOTE': '1', 19:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:48 INFO - 'NO_EM_RESTART': '1', 19:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:48 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:48 INFO - 'SHELL': '/bin/bash', 19:04:48 INFO - 'SHLVL': '1', 19:04:48 INFO - 'TERM': 'linux', 19:04:48 INFO - 'TMOUT': '86400', 19:04:48 INFO - 'USER': 'cltbld', 19:04:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:48 INFO - '_': '/tools/buildbot/bin/python'} 19:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:48 INFO - Downloading/unpacking psutil>=0.7.1 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:04:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:04:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:50 INFO - Installing collected packages: psutil 19:04:50 INFO - Running setup.py install for psutil 19:04:50 INFO - building 'psutil._psutil_linux' extension 19:04:50 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 19:04:50 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 19:04:50 INFO - building 'psutil._psutil_posix' extension 19:04:50 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 19:04:50 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 19:04:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:50 INFO - Successfully installed psutil 19:04:50 INFO - Cleaning up... 19:04:50 INFO - Return code: 0 19:04:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:04: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')]} 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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')]} 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04: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', '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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:04: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 mozsystemmonitor==0.0.0 19:04:50 INFO - Using env: {'DISPLAY': ':0', 19:04:50 INFO - 'HOME': '/home/cltbld', 19:04:50 INFO - 'LANG': 'en_US.UTF-8', 19:04:50 INFO - 'LANGUAGE': 'en_US:en', 19:04:50 INFO - 'LOGNAME': 'cltbld', 19:04:50 INFO - 'MAIL': '/var/mail/cltbld', 19:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:50 INFO - 'MOZ_NO_REMOTE': '1', 19:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:50 INFO - 'NO_EM_RESTART': '1', 19:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:50 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:50 INFO - 'SHELL': '/bin/bash', 19:04:50 INFO - 'SHLVL': '1', 19:04:50 INFO - 'TERM': 'linux', 19:04:50 INFO - 'TMOUT': '86400', 19:04:50 INFO - 'USER': 'cltbld', 19:04:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:50 INFO - '_': '/tools/buildbot/bin/python'} 19:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:51 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 19:04:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:04:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:04:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:04:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:04:52 INFO - Installing collected packages: mozsystemmonitor 19:04:52 INFO - Running setup.py install for mozsystemmonitor 19:04:52 INFO - Successfully installed mozsystemmonitor 19:04:52 INFO - Cleaning up... 19:04:52 INFO - Return code: 0 19:04:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:52 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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04:52 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 19:04:52 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 19:04:52 INFO - Using env: {'DISPLAY': ':0', 19:04:52 INFO - 'HOME': '/home/cltbld', 19:04:52 INFO - 'LANG': 'en_US.UTF-8', 19:04:52 INFO - 'LANGUAGE': 'en_US:en', 19:04:52 INFO - 'LOGNAME': 'cltbld', 19:04:52 INFO - 'MAIL': '/var/mail/cltbld', 19:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:52 INFO - 'MOZ_NO_REMOTE': '1', 19:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:52 INFO - 'NO_EM_RESTART': '1', 19:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:52 INFO - 'SHELL': '/bin/bash', 19:04:52 INFO - 'SHLVL': '1', 19:04:52 INFO - 'TERM': 'linux', 19:04:52 INFO - 'TMOUT': '86400', 19:04:52 INFO - 'USER': 'cltbld', 19:04:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:52 INFO - '_': '/tools/buildbot/bin/python'} 19:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:53 INFO - Downloading/unpacking blobuploader==1.2.4 19:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:04:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:04:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:04:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:54 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 19:04:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:04:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:04:55 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 19:04:55 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 19:04:55 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 19:04:55 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 19:04:55 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 19:04:55 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 19:04:55 INFO - Downloading docopt-0.6.1.tar.gz 19:04:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:04:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:04:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:04:55 INFO - Running setup.py install for blobuploader 19:04:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:04:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:04:55 INFO - Running setup.py install for requests 19:04:55 INFO - Running setup.py install for docopt 19:04:56 INFO - Successfully installed blobuploader requests docopt 19:04:56 INFO - Cleaning up... 19:04:56 INFO - Return code: 0 19:04:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:56 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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04:56 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 19:04:56 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 19:04:56 INFO - Using env: {'DISPLAY': ':0', 19:04:56 INFO - 'HOME': '/home/cltbld', 19:04:56 INFO - 'LANG': 'en_US.UTF-8', 19:04:56 INFO - 'LANGUAGE': 'en_US:en', 19:04:56 INFO - 'LOGNAME': 'cltbld', 19:04:56 INFO - 'MAIL': '/var/mail/cltbld', 19:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:56 INFO - 'MOZ_NO_REMOTE': '1', 19:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:56 INFO - 'NO_EM_RESTART': '1', 19:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:56 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:56 INFO - 'SHELL': '/bin/bash', 19:04:56 INFO - 'SHLVL': '1', 19:04:56 INFO - 'TERM': 'linux', 19:04:56 INFO - 'TMOUT': '86400', 19:04:56 INFO - 'USER': 'cltbld', 19:04:56 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:56 INFO - '_': '/tools/buildbot/bin/python'} 19:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:04:56 INFO - Running setup.py (path:/tmp/pip-hn9MPi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:04:56 INFO - Running setup.py (path:/tmp/pip-H3cg09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:04:56 INFO - Running setup.py (path:/tmp/pip-WnVLPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:04:56 INFO - Running setup.py (path:/tmp/pip-LZOJsd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:04:56 INFO - Running setup.py (path:/tmp/pip-CgxYBC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:04:56 INFO - Running setup.py (path:/tmp/pip-6w3hn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:04:56 INFO - Running setup.py (path:/tmp/pip-OXAGb8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:04:56 INFO - Running setup.py (path:/tmp/pip-P_V0U7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:04:56 INFO - Running setup.py (path:/tmp/pip-DEDU4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:04:56 INFO - Running setup.py (path:/tmp/pip-yk5bjG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:04:57 INFO - Running setup.py (path:/tmp/pip-XyHAIi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:04:57 INFO - Running setup.py (path:/tmp/pip-Ld3yWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:04:57 INFO - Running setup.py (path:/tmp/pip-B_DV93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:04:57 INFO - Running setup.py (path:/tmp/pip-aRq3Pe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:04:57 INFO - Running setup.py (path:/tmp/pip-3pymPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:04:57 INFO - Running setup.py (path:/tmp/pip-0LfzYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:04:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:04:57 INFO - Running setup.py (path:/tmp/pip-TYnpbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:04:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:04:57 INFO - Running setup.py install for manifestparser 19:04:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:04:57 INFO - Running setup.py install for mozcrash 19:04:57 INFO - Running setup.py install for mozdebug 19:04:57 INFO - Running setup.py install for mozdevice 19:04:57 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:04:57 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:04:57 INFO - Running setup.py install for mozfile 19:04:58 INFO - Running setup.py install for mozhttpd 19:04:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for mozinfo 19:04:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for mozInstall 19:04:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for mozleak 19:04:58 INFO - Running setup.py install for mozlog 19:04:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for moznetwork 19:04:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for mozprocess 19:04:58 INFO - Running setup.py install for mozprofile 19:04:58 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Running setup.py install for mozrunner 19:04:58 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:04:59 INFO - Running setup.py install for mozscreenshot 19:04:59 INFO - Running setup.py install for moztest 19:04:59 INFO - Running setup.py install for mozversion 19:04:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:04:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:59 INFO - Cleaning up... 19:04:59 INFO - Return code: 0 19:04:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:59 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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:04:59 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 19:04:59 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 19:04:59 INFO - Using env: {'DISPLAY': ':0', 19:04:59 INFO - 'HOME': '/home/cltbld', 19:04:59 INFO - 'LANG': 'en_US.UTF-8', 19:04:59 INFO - 'LANGUAGE': 'en_US:en', 19:04:59 INFO - 'LOGNAME': 'cltbld', 19:04:59 INFO - 'MAIL': '/var/mail/cltbld', 19:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:59 INFO - 'MOZ_NO_REMOTE': '1', 19:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:59 INFO - 'NO_EM_RESTART': '1', 19:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:59 INFO - 'SHELL': '/bin/bash', 19:04:59 INFO - 'SHLVL': '1', 19:04:59 INFO - 'TERM': 'linux', 19:04:59 INFO - 'TMOUT': '86400', 19:04:59 INFO - 'USER': 'cltbld', 19:04:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:59 INFO - '_': '/tools/buildbot/bin/python'} 19:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:04:59 INFO - Running setup.py (path:/tmp/pip-_uiotF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:04:59 INFO - Running setup.py (path:/tmp/pip-gKRJt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:04:59 INFO - Running setup.py (path:/tmp/pip-23Xbgx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:04:59 INFO - Running setup.py (path:/tmp/pip-y1VqS3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:04:59 INFO - Running setup.py (path:/tmp/pip-SSA5ao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:04:59 INFO - Running setup.py (path:/tmp/pip-6Zjkxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:04:59 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)) 19:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:04:59 INFO - Running setup.py (path:/tmp/pip-pmWrh8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:05:00 INFO - Running setup.py (path:/tmp/pip-KxcuOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:05:00 INFO - Running setup.py (path:/tmp/pip-v3m9KC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:05:00 INFO - Running setup.py (path:/tmp/pip-nUQRC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:05:00 INFO - Running setup.py (path:/tmp/pip-FEq2p1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:05:00 INFO - Running setup.py (path:/tmp/pip-plRaAZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:05:00 INFO - Running setup.py (path:/tmp/pip-ZSww08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:05:00 INFO - Running setup.py (path:/tmp/pip-YmySfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:05:00 INFO - Running setup.py (path:/tmp/pip-2pALll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:05:00 INFO - Running setup.py (path:/tmp/pip-1sJKES-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:05:00 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)) 19:05:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:05:00 INFO - Running setup.py (path:/tmp/pip-f3fIP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:05:00 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)) 19:05:00 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)) 19:05:00 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)) 19:05:00 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)) 19:05: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 mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:02 INFO - Downloading blessings-1.5.1.tar.gz 19:05:02 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 19:05:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:02 INFO - Installing collected packages: blessings 19:05:02 INFO - Running setup.py install for blessings 19:05:02 INFO - Successfully installed blessings 19:05:02 INFO - Cleaning up... 19:05:02 INFO - Return code: 0 19:05:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:05:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:05:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:05:02 INFO - Reading from file tmpfile_stdout 19:05:02 INFO - Current package versions: 19:05:02 INFO - argparse == 1.2.1 19:05:02 INFO - blessings == 1.5.1 19:05:02 INFO - blobuploader == 1.2.4 19:05:02 INFO - docopt == 0.6.1 19:05:02 INFO - manifestparser == 1.1 19:05:02 INFO - mozInstall == 1.12 19:05:02 INFO - mozcrash == 0.16 19:05:02 INFO - mozdebug == 0.1 19:05:02 INFO - mozdevice == 0.48 19:05:02 INFO - mozfile == 1.2 19:05:02 INFO - mozhttpd == 0.7 19:05:02 INFO - mozinfo == 0.9 19:05:02 INFO - mozleak == 0.1 19:05:02 INFO - mozlog == 3.1 19:05:02 INFO - moznetwork == 0.27 19:05:02 INFO - mozprocess == 0.22 19:05:02 INFO - mozprofile == 0.28 19:05:02 INFO - mozrunner == 6.11 19:05:02 INFO - mozscreenshot == 0.1 19:05:02 INFO - mozsystemmonitor == 0.0 19:05:02 INFO - moztest == 0.7 19:05:02 INFO - mozversion == 1.4 19:05:02 INFO - psutil == 3.1.1 19:05:02 INFO - requests == 1.2.3 19:05:02 INFO - wsgiref == 0.1.2 19:05:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:05: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')]} 19:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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', '-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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:05:02 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 19:05:02 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 19:05:02 INFO - Using env: {'DISPLAY': ':0', 19:05:02 INFO - 'HOME': '/home/cltbld', 19:05:02 INFO - 'LANG': 'en_US.UTF-8', 19:05:02 INFO - 'LANGUAGE': 'en_US:en', 19:05:02 INFO - 'LOGNAME': 'cltbld', 19:05:02 INFO - 'MAIL': '/var/mail/cltbld', 19:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:02 INFO - 'MOZ_NO_REMOTE': '1', 19:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:02 INFO - 'NO_EM_RESTART': '1', 19:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 19:05:02 INFO - 'SHELL': '/bin/bash', 19:05:02 INFO - 'SHLVL': '1', 19:05:02 INFO - 'TERM': 'linux', 19:05:02 INFO - 'TMOUT': '86400', 19:05:02 INFO - 'USER': 'cltbld', 19:05:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:02 INFO - '_': '/tools/buildbot/bin/python'} 19:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 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)) 19:05:03 INFO - Cleaning up... 19:05:03 INFO - Return code: 0 19:05:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:05:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:05:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:03 INFO - Using env: {'DISPLAY': ':0', 19:05:03 INFO - 'HOME': '/home/cltbld', 19:05:03 INFO - 'LANG': 'en_US.UTF-8', 19:05:03 INFO - 'LANGUAGE': 'en_US:en', 19:05:03 INFO - 'LOGNAME': 'cltbld', 19:05:03 INFO - 'MAIL': '/var/mail/cltbld', 19:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:03 INFO - 'MOZ_NO_REMOTE': '1', 19:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:03 INFO - 'NO_EM_RESTART': '1', 19:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:05:03 INFO - 'PWD': '/builds/slave/test-pgo', 19:05:03 INFO - 'SHELL': '/bin/bash', 19:05:03 INFO - 'SHLVL': '1', 19:05:03 INFO - 'TERM': 'linux', 19:05:03 INFO - 'TMOUT': '86400', 19:05:03 INFO - 'USER': 'cltbld', 19:05:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:03 INFO - '_': '/tools/buildbot/bin/python'} 19:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:03 INFO - Downloading/unpacking jsonschema 19:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:05 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 19:05:05 INFO - Downloading/unpacking functools32 (from jsonschema) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:05:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:05 INFO - warning: no files found matching '*.txt' 19:05:05 INFO - no previously-included directories found matching 'build' 19:05:05 INFO - no previously-included directories found matching 'dist' 19:05:05 INFO - no previously-included directories found matching '.git*' 19:05:05 INFO - Installing collected packages: jsonschema, functools32 19:05:05 INFO - Running setup.py install for functools32 19:05:05 INFO - warning: no files found matching '*.txt' 19:05:05 INFO - no previously-included directories found matching 'build' 19:05:05 INFO - no previously-included directories found matching 'dist' 19:05:05 INFO - no previously-included directories found matching '.git*' 19:05:05 INFO - Successfully installed jsonschema functools32 19:05:05 INFO - Cleaning up... 19:05:05 INFO - Return code: 0 19:05:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:05:05 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')]} 19:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 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')]} 19:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:05 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 0x7fd43c539f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a28630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, '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': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', '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 19:05:05 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 19:05:05 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 19:05:05 INFO - Using env: {'DISPLAY': ':0', 19:05:05 INFO - 'HOME': '/home/cltbld', 19:05:05 INFO - 'LANG': 'en_US.UTF-8', 19:05:05 INFO - 'LANGUAGE': 'en_US:en', 19:05:05 INFO - 'LOGNAME': 'cltbld', 19:05:05 INFO - 'MAIL': '/var/mail/cltbld', 19:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:05 INFO - 'MOZ_NO_REMOTE': '1', 19:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:05 INFO - 'NO_EM_RESTART': '1', 19:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:05:05 INFO - 'PWD': '/builds/slave/test-pgo', 19:05:05 INFO - 'SHELL': '/bin/bash', 19:05:05 INFO - 'SHLVL': '1', 19:05:05 INFO - 'TERM': 'linux', 19:05:05 INFO - 'TMOUT': '86400', 19:05:05 INFO - 'USER': 'cltbld', 19:05:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:05 INFO - '_': '/tools/buildbot/bin/python'} 19:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:05 INFO - Downloading/unpacking flake8 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:05:07 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 19:05:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:05:07 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 19:05:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:07 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 19:05:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:05:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:08 INFO - no previously-included directories found matching 'docs/_build' 19:05:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:05:08 INFO - Running setup.py install for pep8 19:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:08 INFO - no previously-included directories found matching 'docs/_build' 19:05:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:05:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:05:08 INFO - Cleaning up... 19:05:08 INFO - Return code: 0 19:05:08 INFO - Running post-action listener: _resource_record_post_action 19:05:08 INFO - Running post-action listener: _start_resource_monitoring 19:05:08 INFO - Starting resource monitoring. 19:05:08 INFO - ##### 19:05:08 INFO - ##### Running install step. 19:05:08 INFO - ##### 19:05:08 INFO - Running pre-action listener: _resource_record_pre_action 19:05:08 INFO - Running main action method: install 19:05:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:05:08 INFO - Reading from file tmpfile_stdout 19:05:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:05:08 INFO - Reading from file tmpfile_stdout 19:05:08 INFO - Output received: 19:05:08 INFO - Usage: mozinstall [options] installer 19:05:08 INFO - Options: 19:05:08 INFO - -h, --help show this help message and exit 19:05:08 INFO - -d DEST, --destination=DEST 19:05:08 INFO - Directory to install application into. [default: 19:05:08 INFO - "/builds/slave/test-pgo"] 19:05:08 INFO - --app=APP Application being installed. [default: firefox] 19:05:08 INFO - mkdir: /builds/slave/test-pgo/build/application 19:05:08 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'] 19:05:08 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 19:05:24 INFO - Reading from file tmpfile_stdout 19:05:24 INFO - Output received: 19:05:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:05:24 INFO - Running post-action listener: _resource_record_post_action 19:05:24 INFO - ##### 19:05:24 INFO - ##### Running run-tests step. 19:05:24 INFO - ##### 19:05:24 INFO - Running pre-action listener: _resource_record_pre_action 19:05:24 INFO - Running main action method: run_tests 19:05:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:05:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:05:24 INFO - Python 2.7.3 19:05:24 INFO - Return code: 0 19:05:24 INFO - grabbing minidump binary from tooltool 19:05:24 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')]} 19:05:24 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 0x2ab9840>, '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 0x2a266b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a26b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:05:24 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 19:05:24 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 19:05:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:24 INFO - Return code: 0 19:05:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:05:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:05:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:05:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:05:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:05:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:05:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:05:25 INFO - Return code: 0 19:05:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:05:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 19:05:25 INFO - Using env: {'DISPLAY': ':0', 19:05:25 INFO - 'HOME': '/home/cltbld', 19:05:25 INFO - 'LANG': 'en_US.UTF-8', 19:05:25 INFO - 'LANGUAGE': 'en_US:en', 19:05:25 INFO - 'LOGNAME': 'cltbld', 19:05:25 INFO - 'MAIL': '/var/mail/cltbld', 19:05:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:05:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:25 INFO - 'MOZ_NO_REMOTE': '1', 19:05:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:25 INFO - 'NO_EM_RESTART': '1', 19:05:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:05:25 INFO - 'PWD': '/builds/slave/test-pgo', 19:05:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:05:25 INFO - 'SHELL': '/bin/bash', 19:05:25 INFO - 'SHLVL': '1', 19:05:25 INFO - 'TERM': 'linux', 19:05:25 INFO - 'TMOUT': '86400', 19:05:25 INFO - 'USER': 'cltbld', 19:05:25 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579', 19:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:25 INFO - '_': '/tools/buildbot/bin/python'} 19:05:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 19:05:25 INFO - mozversion application_buildid: 20160114173018 19:05:25 INFO - mozversion application_changeset: 0d39fb92a77487fe494da2b3721815aa50cec625 19:05:25 INFO - mozversion application_display_name: Nightly 19:05:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:25 INFO - mozversion application_name: Firefox 19:05:25 INFO - mozversion application_remotingname: firefox 19:05:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:05:25 INFO - mozversion application_vendor: Mozilla 19:05:25 INFO - mozversion application_version: 46.0a1 19:05:25 INFO - mozversion platform_buildid: 20160114173018 19:05:25 INFO - mozversion platform_changeset: 0d39fb92a77487fe494da2b3721815aa50cec625 19:05:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:05:25 INFO - mozversion platform_version: 46.0a1 19:05:25 INFO - using testdate: 1452827125 19:05:25 INFO - actual date: 1452827125 19:05:25 INFO - starting webserver on 'localhost:58806' 19:05:25 INFO - SUITE-START | Running 3 tests 19:05:25 INFO - TEST-START | dromaeo_css 19:05:25 INFO - operating with platform_type : linux_ 19:05:25 INFO - Initialising browser for dromaeo_css test... 19:05:25 INFO - TEST-INFO | started process 27060 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph7U2Ih/profile http://localhost:58806/getInfo.html) 19:05:29 INFO - PROCESS | 27060 | 19:05:29 INFO - PROCESS | 27060 | (process:27142): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:05:30 INFO - PROCESS | 27060 | __metrics Screen width/height:1600/1200 19:05:30 INFO - PROCESS | 27060 | colorDepth:24 19:05:30 INFO - PROCESS | 27060 | Browser inner width/height: 1024/697 19:05:30 INFO - PROCESS | 27060 | __metrics 19:05:30 INFO - PROCESS | 27060 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:05:30 INFO - PROCESS | 27060 | 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. 19:05:31 INFO - TEST-INFO | 27060: exit 0 19:05:31 INFO - Browser initialized. 19:05:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:31 INFO - TEST-INFO | started process 27191 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph7U2Ih/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:32 INFO - PROCESS | 27191 | 19:05:32 INFO - PROCESS | 27191 | (process:27249): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:05:43 INFO - PROCESS | 27191 | RSS: Main: 150777856 19:05:43 INFO - PROCESS | 27191 | 19:06:32 INFO - PROCESS | 27191 | 1452827192755 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] 19:08:41 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58806/tests/dromaeo/cssquery-ext.html) 19:08:42 INFO - PROCESS | 27191 | RSS: Main: 156110848 19:08:42 INFO - PROCESS | 27191 | 19:11:44 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-ext.html (next: http://localhost:58806/tests/dromaeo/cssquery-jquery.html) 19:11:44 INFO - PROCESS | 27191 | RSS: Main: 153649152 19:11:44 INFO - PROCESS | 27191 | 19:14:46 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58806/tests/dromaeo/cssquery-mootools.html) 19:14:47 INFO - PROCESS | 27191 | RSS: Main: 151461888 19:14:47 INFO - PROCESS | 27191 | 19:17:48 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58806/tests/dromaeo/cssquery-prototype.html) 19:17:49 INFO - PROCESS | 27191 | RSS: Main: 150720512 19:17:49 INFO - PROCESS | 27191 | 19:20:51 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58806/tests/dromaeo/cssquery-yui.html) 19:20:52 INFO - PROCESS | 27191 | RSS: Main: 151699456 19:20:52 INFO - PROCESS | 27191 | 19:23:54 INFO - PROCESS | 27191 | Cycle 1(1): loaded http://localhost:58806/tests/dromaeo/cssquery-yui.html (next: http://localhost:58806/tests/dromaeo/cssquery-dojo.html) 19:23:55 INFO - PROCESS | 27191 | RSS: Main: 153575424 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | __start_tp_report 19:23:55 INFO - PROCESS | 27191 | _x_x_mozilla_page_load 19:23:55 INFO - PROCESS | 27191 | _x_x_mozilla_page_load_details 19:23:55 INFO - PROCESS | 27191 | |i|pagename|runs| 19:23:55 INFO - PROCESS | 27191 | |0;dojo.html;3172.5875636167293;3211.951820722688;3236.983815080924;3252.8861489847855;3255.8534865931033;5093.439721630618;5232.947670523294;5241.42344342122;5242.344706911631;5256.92114618281;5159.071367153921;5216.191490319006;5233.267342572033;5258.6318957672975;5276.366835979678;4733.384659994204;4769.642276829234;4801.951980480186;4821.373221481203;4878.878028049309;4794.760261986887;4816.783244753994;4854.8300809471675;4867.610591152717;4914.410270767513;4756.191447453941;4757.452892917324;4823.710577365352;4826.131296366652;4838.129136755382;4830.2030165022725;4837.637177211688;4880.292357608162;4883.096627123993;4891.657583969123;4843.321934929113;4860.878478038042;4867.050925069613;4875.34182885313;4877.268409738532;4934.506549345073;4951.5048495150195;5120.02719483297;5192.584593232532;5196.29849970253;5623.8594035149445;5638;5649.180868774046;5690.60165788395;5694.544436445074;5676;5679.886402271973;5693.202951586781;5705.657660540381;5723.227364305807;5138.2806407103035;5198.506141916512;5297.099493086184;5366.6243362964215;5400.891982160374;5722.17028530869;5726.026575482178;5727.083666613322;5732.914006289909;5738.913916291259;5375.596830237748;5518.944810551923;5528.170774383874;5529.447055294519;5533.806316778893;5584.692841893653;5609.326880774333;5640.7743690252755;5655.179998900218;5704.515116215085;5555.416681248492;5579.804706835242;5590.273264475673;5591;5596.944030559724;5526.806561770319;5529.972350138223;5565.276514053147;5590.580706446952;5600.5799565032785;4327.242732521859;4355.499117601453;4359.215341238544;4391.3193455014525;4396.648268138605;3800.8859734208017;3851.4030325299623;3894.824732887027;3911.7457365271166;3965.464662270614;5136.5890728741615;5197.908439227805;5275.261463395128;5326.92009619856;5374.220737992969;5587.1339942309005;5630.859228519238;5654.06707893193;5664.660120392789;5716.57125715573;5203.583713302926;5244.29202057725;5245.160774276097;5258.421573626898;5314.441983591667;4747.8575642730775;4815.6388270879825;4817.470078291385;4830.806767729251;4878.195097808893;5803.9419605803405;5817.3019237690905;5825.0679891217205;5833.183354330397;5852.15143804146;5598.384177740364;5601.579881508822;5601.859953501032;5604.047311956896;5612.775488980558;5763.221965034667;5770.682612456188;5772.913406298993;5799.391063938226;5851.385604511635;5543.8891222176135;5544.057510223352;5558.44415558441;5559.11054231321;5562.972185139049;5466.4260252674485;5590.2453168821685;5632.971835140798;5633.1831884375715;5652.68910209926;5525.972370138124;5532.419095994863;5547.722613869209;5585.5252303553025;5657.575681823962;5494.478024587658;5496.725163741717;5512.310961129859;5513.117901135799;5519.806806761744;5386.030514507426;5406.702631355313;5422.403535611158;5463.672179669233;5474.972625136849;5482.068048431696;5523.171524271392;5537.307836520435;5564.165375193753;5566.332040155207;5422.024035673617;5429.131338985743;5458.890822183614;5465.207544905887;5482.588805839658 19:23:55 INFO - PROCESS | 27191 | |1;ext.html;542.1975476295083;554.2517601238329;578.7222133375982;591.7159763313609;592.5851903667433;27248.63756812159;27857.58213626797;35444.468332975026;35793;35869.2826143477;38787;39236.60763392365;39354.606453935456;39542.40686389699;39585.20829583414;8443.071262161142;8594;8624.180702833251;8624.35317351198;8624.65501379944;8384.203500667427;8439.240468357846;8475.788105297386;8501.489910605353;8504.957475212646;8453.577321133918;8584.656613735444;8755.299576033902;8760.342974276955;8786.912130878705;8634.266087382548;8702.042775294713;8719.869201961976;8726.214640682305;8727.694530691428;8516.489010659318;8635.913640863573;8652.134786521297;8652.82694346116;8662.436941598839;39663;39731.4040289393;40078.19843603141;40081.39877901834;40140.59859401427;3282.983585082083;3455.568053993251;3569.6430356964356;3622.1669016126175;3735.8505659773577;29472.70527294721;29789.40421191586;30259.092227233217;30447.086587402413;30682.386352273053;3934.272159650474;3957.980210098931;3964.86122985697;4028.4561584186054;4113.691473139496;273135;274284;275649;275731.999999998;278152;41663.79168104201;41716.791416042724;42080;42245.36631950462;52854.73572632112;39713.80143099266;39778.80110599429;40042.799786001466;40083.59916400857;40099.79950100231;15082.849171508144;15194.924025379802;15217;15217.391304347924;15241.23793810305;11779.116566257566;11940.402979850973;11988.700282493008;12014.879851201551;12224.938875305566;14245.715085698228;14259.21574313402;14395;14395.136291822524;14453.421863125357;5577.358603760619;5680.346760122638;5697.373288938214;5742.425757424307;5760.8271751847515;917.7881306052515;942.4298299528823;983.9262055345878;1019.0777346501428;1028;28552.428951420854;30779.230519237197;30795.230119247197;30944;31416;998.7353351361895;1012.9240306977006;1016.8068067067234;1030.4023666273692;1078.9730256743487;14294.356753945889;14550.981431299919;14842.777358339634;14899.255037248095;14930;420179;422350;430607;430647;431469;52934.20598691023;53406.73296633492;53407.92624700647;53431.46568534343;53915;1313.7175507265983;1327.1307293722627;1333.8065980432978;1333.8666133386778;1348.1843484691817;27679.861600691867;28532.57201141943;28555.714442855304;28678;28833.42333153367;45926.77036614795;46369.30446043379;46405.07189856117;46664.30003549882;46674.066518670115;263187;265404;265826;266365;266456;27258.591121132802;27752.722472775014;30300.24249393783;30775.53836692496;31976.360472789947;36346.81826590956;36726;36818.81590592137;37017.074573135884;37298.440523391626;31490.685093148775;31631.84184079065;31948.6805131955;34844.303113938084;35308.82345588256;34059.82970085134;34084.1478963018;34279;34459.310813783086;34754.82622586871;33226;34069.318613628086;34190.31619367649;34411.82794086014;34426;29272.56091158592;31334.373312533167;31441;31787;31912.202194944384;23814.404639883447;24116.247874457138;24138.87930560336;24226.273211803673;24406.75593244116 19:23:55 INFO - PROCESS | 27191 | |2;jquery.html;361.76304520539037;362.49251048532057;362.88206332941786;362.95644522657284;369.3591618541828;15692.293846776894;16174.2721577529;16800.159992000412;16810.411635592758;17542.298308067693;10200.642977495789;10414.63548775791;15421.537353879374;15922.76115858263;15930.522084337488;5652.406497317774;6035.155078289043;6079.179310793031;6096.847578810521;6111.511079113682;5935.732892019848;5989.520838332923;6029.849253768647;6202.9379706203035;6470.385313395243;6168.75324987;6405.103285540028;6442.420182183602;6444.323346048668;6455.193100862392;6368.458681012119;6373.298937116913;6385.999999999976;6432.967835160841;6743.494237932175;6270.122182894398;6381;6423.100765892778;6438.066480360369;6459.741610335581;21359.466013349636;21832;22023.449413764785;22038.33884983453;22412.88793556022;2073.2950796729033;2164.675298705207;2209.55808838233;2348.7533808949984;2356.552255071531;13284.202947823162;13660.316984150852;14000.299985000811;14003.299835008209;14112;1893.2710906301036;1907.3961168032247;1917.570412347468;1962.5682349883002;1964.479412955568;60283.69858150725;62450.37549624491;63141.36858631447;63671.68164159196;64455.67772161109;14659.727662377158;15154.393824246907;15244.618884527976;15255.466058687893;15737.763933541006;22878.542429151323;23180;23349.416264593183;23538.882305588362;23576.410589735395;7058.470614703918;7331.716949533917;7339.926600733925;7380.372668323145;9085.364024518352;7369.263073692695;7373.225811289844;7374.410047196211;7418.035655364876;7463.275904294893;4358.150160718629;4420.756858372756;4449.132419178294;4453.51011388747;4501.48232953208;1745.171043754232;1794.7218181181938;1818.509002569299;1822.9726554101699;1829.3962992212537;912.7216199059218;956.3257903178243;961.4137968863735;961.4711908450324;974.1476208317722;15188.544343669708;15592.610184745472;16063.11652859104;16388;16455.83544164543;885.2608072259735;929.6188562689265;951.4338968313842;984.8818141823027;994.7662299359645;8889.955550222208;9037.457752534869;9062.592183351633;9151.901771787296;9302.720918372459;373707;378923;382266;382562;430894;73032.63483682547;73260;73525.63237183887;74443.25556744472;76361.61819190868;1027.701966429742;1064.462446464546;1069.6363236499471;1070.3577853287966;1081.1350919264557;14189.787153192505;14667.48663796762;15008.399664013317;15010.77483837765;15039.323230454436;28924;30374;31474;32604.184895376857;32613.836930815192;42722.223055501294;42987;43097;44181.55818441774;44469.77765111154;6974.37230649244;7015.754448594274;7042.718291268292;7054.259302773135;7167.426605871622;9787.608495660093;10734.516946737573;10900.127989760958;11092.112630989663;11488;7914;9016.954915225382;9332.313736074348;9383.436993780395;9393.107654773059;9153.17621414076;9169.908300916906;9414.199793017397;9417.764555886157;9517.143457088896;9225.677101301422;9779.559919803769;10028.548715307683;10055.346402483816;10142.340747851365;7424;7584.241575842592;7623.542587444771;7653.311201991847;7658.234176582298;8799.47203167812;9364.297677674065;9642.758931026781;9667.468289243878;9699.884513281064 19:23:55 INFO - PROCESS | 27191 | |3;mootools.html;1386.9375878085484;1418.531884478122;1533.5246073717142;1703.2846204594084;1716.270585001375;7601.695932162714;7627.80930476737;7730.768076957694;7772.222777722232;7841.294283514482;7867.331276841475;7895.8420831583335;7903.407244456675;7939.483933544316;7964.840703185947;2323.732770731362;2347.647852822073;2351.5414494173556;2352.7411984681758;2355.3993731598416;2350.9294721158394;2375.251795684354;2375.679283296759;2381.1784934197763;2384.248961577098;2299.839011269212;2316.6872472216287;2341.4146463384154;2345.589521833681;2348.612478940973;2284.565932472825;2302.4013756423283;2333.2416964486524;2341.7892389684926;2341.8360714749974;2310.9422264443524;2315.282262498614;2316.027268547214;2328.092044102801;2332.137109269564;7446.441516886255;7456.701731930716;7494.475386722877;7535.171131175566;7538.8115297117465;4705.270683044099;4784.425868895755;4815.66290359675;4846.515348465161;4857.417109946829;3081.229692576856;3119.485284927984;3156.2425017995515;3173;3207.1982004498877;1080.9414523163753;1084.1164450972433;1100.312304809494;1103.564092183591;1141.3323205924462;10590.894091059068;10733.195010374253;10815.782764533331;10824.971627695435;10839;4250.957490425056;4303.677224208197;4396.780160991938;4456.17560751262;4480.551944805494;9193.356465047516;9238.67664631748;9252.629894804133;9294.86057709135;9302.930163031202;4878.707277563358;4897.338859254026;4905.607551395879;4926.802927882916;4932.383452068491;4441.400410944481;4452.332150177499;4471.23988921884;4472.2620767573635;4487.214737420938;3533.452314891196;3653.159773252167;3672.5042119314085;3674.356987527172;3698.2973235085788;1116.5924437580225;1171.1860257121218;1198.5505435461703;1201.9759604807855;1208.528673817212;976.3751199232497;988.9109980101825;1013.1337706261188;1093.191038631407;1243.2043492165021;7072.222055573883;7177.89233161503;7188.281171882874;7232.20445750967;7240.05879235696;619.3837132053545;627.6077451592755;629.134939458245;631.4127861089231;757.9848403032018;5205.453427390145;5268.2097685346735;5273.973630131824;5282.603804714662;5293.12663410533;8926.553672316359;9006.144416280444;9423.481708506099;9449.196818270386;9637.518124093767;9311.208547273422;9364.34449588536;9385.57764900581;9469.14777670013;9499.38254013487;7292.781216563511;7306.232845551247;7462.738804141937;7513.47405681608;7513.812154696177;7121.430285577245;7129.857402852018;7145.535540189871;7147;7159.8568028640175;8176.591170441335;8379.329653627574;8459.661613535636;8527.701530446404;8553.82892342162;8114.513129212266;8291.33669306442;8310.626021828912;8322.958385208036;8323.41736078493;6910.965445172742;6969.895451568332;7059.435245180476;7066.646667666699;7079.079719636415;7568.508046977149;7613.390928725799;7615.314621684075;7620.885686714814;7621.733239336597;6804.9319506804295;6939.653017349011;7167.605781682058;7249.202587715453;7282.708691652275;6469.159009328757;6503.902441463287;6553;6590.143281373391;6862.862742745217;6506;6649.069130321662;6659.167604049494;6663.566868153554;6754.223264324665;6035.818925432244;6044.486218671462;6046.395360463918;6116.694165291807;6126.816195514141;6038.63768173911;6132.754689812536;6144.692765361803;6186.288576813724;6230.283517395557 19:23:55 INFO - PROCESS | 27191 | |4;prototype.html;343.5259342107891;344.2478185165414;348.60259304392997;349.34323471872875;355.79363968898036;6235.095911092894;6312.652804095773;6345.650989195592;6348.428641422271;6431;6267.467265282445;6304.936950630492;6320.11518387425;6327.525435592326;6353.841153971153;4819.590334821544;4840.9757951210195;4845.3216549683075;4850.199717046683;4855.465898751135;4842.394700662418;4844.660873738822;4848.127337079324;4851.102546028978;4851.490593487686;4710.26990816424;4783.593394561449;4812.10975969445;4813.350197723297;4827.155247831633;4796.52034796521;4797.184478638605;4801.063792560452;4809.254565542346;4820.156472617278;4169.854055108057;4187.14163596462;4198.874033778991;4199.097194103252;4205.158968206371;5989.221401217857;6044.365341639109;6071.301800292978;6093.268807743099;6097.3292937776805;5537.224788529609;5622.859428514279;5636.267285252891;5640.464155905223;5643.943560564383;6738.966305168492;6743.5953842769595;6750.662466876685;6764.0530325754435;6768.458523318172;4630.513796051399;4634.050019745978;4639.257718765015;4641.675082744209;4642.698224615389;6872.793816185523;6944.7222111116;6987.196472405688;6996.370326670624;7019.333163349474;4711.8350857719815;4716.528347165325;4724.811007559728;4726.078414709099;4728.4798672146035;4733.360996265529;4760.166970780099;4792.520747925179;4794.712317260975;4802.615790736732;5552;5564.054110801174;5566.053770858964;5572.944270557324;5584.497395234448;6507.349265073455;6738.460923126138;6739.494537909676;6761.492888033319;6763.864722705518;1614.6124930016947;1619.295606411215;1621.4568119679805;1624.4720465848648;1663.25984936702;1110.2616759854768;1115.6262652011505;1124.2636073371955;1131.9151063670092;1139.1797905508022;6148.354422785543;6181.598196117238;6313.621182729051;6327.240731112204;6343.5876668016435;6901.827454313682;6907.240203577602;6930.965345173343;6933.1333583302085;6947.062146610244;6171;6301.464375528131;6303.6217826929615;6306.8423289417215;6307.3377295383325;3724.776513409204;3751.249750050001;3753.5871054184563;3760.7367484275837;3767.208886133888;7231.963840180765;7239.674214660353;7250.4199664026755;7257.237990011078;7265.2371500992695;6958.3041695831025;7028;7056.400205982549;7076.4692648051605;7082.610456424946;7368.594727289943;7380.298871607189;7384.409247260206;7393.741219057307;7401.407887368998;6999.230084690578;7017.017617533447;7050.118735158106;7050.15398152225;7060.611666358194;6816.591004539743;6892.379685828299;6916.377526022682;6942.8611427772175;6976.651167441709;7309.707611695472;7331.963340183265;7353.5955522446775;7362.484626076123;7382.224866389167;4731.668783185144;4748.976255118702;4751.667383283275;4752.405949256343;4781.091592597395;6830.93169068303;6906.482013848881;6977.511574189758;7009.2990700929495;7065.116860392451;6815.761448349284;6839.521233513607;6857.382835544825;6866.382025617719;6881.036654868422;6814.829629259309;6843.418309443753;6844.794656160323;6850.280720524273;6853.588784672936;6567.2447668518735;6686.29793871656;6715.764948226984;6719.932800671931;6742.528023038536;6870.656467176521;6877.346652068046;6891.173059232924;6897.172339319314;6902.482313826383;6677.198736151693;6693.665316734241;6697.7655782047395;6704.966475167593;6726.217552348729 19:23:55 INFO - PROCESS | 27191 | |5;yui.html;728.3444899590364;736.2232844349213;802.502448481941;802.6709049289789;817.636151912399;12643.431045602947;12756.23462592244;12791.552295669653;12798.296093714842;12843.80734288984;13583.660408489768;13813.654658633539;13816.309184540783;13861.029727919049;13939.163650180997;784.2197013971107;786.6892577431911;796.8565658181525;797.2784629909941;797.4417907464768;790.5217343507153;793.1037927142321;793.9444238903279;794.6106407860136;796.0129439495042;812.3501199040774;812.8861959325699;813.3330668851544;813.5240884082789;814.7515007922581;803.0844836885955;803.694596053496;805.5529181304373;810.266708628692;812.0823469479479;599.2269971736455;601.6179725874058;605.267626172332;607.1560530862105;607.5564837668527;13208.933955330162;13312.134711243738;13325.800112998313;13378.464861405531;13402.731945361136;12179.878201217964;12252;12344.382780861011;12489.18820276679;12630.684232894158;9958.551865166084;10090.899091009069;10144.543495542719;10158.28891977562;10307.226957978182;3493.371193185226;3526;3547.1486843157713;3628.1473853644375;3633.1462106404974;49210.7539462304;49219;49241.50758492405;49443.50556494425;50622;8973.730788076367;9207.907920920705;9248.491332976751;9296.8605470918;9373.1564159226;17573;17603.383881564085;17628.823711762976;17640.470785876445;17658.646827063643;7180.856382872418;7277.963610181915;7293.416526677853;7503.437242206856;7512.962435187789;4175.102352994121;4191.560263611382;4212.873613791591;4228.323468245066;4235.237657221668;3129.8435078246;3148.9685103148677;3152.6689697581883;3174.2857856981996;3191.377681352114;567.6508946997649;570.5749216833402;582.1965687351428;590.5895402695086;597.6354423801478;461.87067621066154;480;537.7069497124077;563.2902542796106;588.8135407154587;8182;8981.416207946462;9107.908920910706;9235.307351948497;9444.811103777885;520.282010825059;539.5602583894114;544.3292451012812;596.6211455725645;659.5548005096541;3965.1276719121747;3987.5613682494904;4241.597048280409;4249.447571815706;4250.72370295936;55235.44764552303;55777.44222557804;56065;56396.43603563912;56506;47812.760936195096;48544.27183592249;48586.27120593194;49403.258951115764;49474.25788613174;44415.33376999348;44671.55328446739;45004.324935126;45093.09813803771;45099.54900451019;8395.580220989048;8444.788880278042;8597.52713600758;8600.612972416382;9058.094190581152;30773.23066923255;33275.83362083271;33744.49383259204;33854.153646159044;34537;43295.783521082194;43313.783431082644;43896.56103439053;43983.560164397946;44324.41051603588;10247.692569222936;10396.272260941661;11025.779484410426;11231.15766317513;11253.043491303331;12447.93776031114;12457.252564846138;12512.687182820502;13078.476860925457;13180.538681146114;11148.554057837595;11525.769484610428;11537.769244614892;11615.941920290345;11731.88268117342;10903.890961090288;10943.179261555575;11038.17213708959;11899.881001189877;12258.26450412978;11321.377324246916;11452.14108941816;11604.42987366086;11607.76784464323;11656.417179141179;9304.488253146143;9510.762230944281;9721.125098740864;9912.542257945595;10043.4476103815;9646.276529260193;9903.900960990586;10009.399436033862;10015.24885633595;10108.1408080314 19:23:55 INFO - PROCESS | 27191 | __end_tp_report 19:23:55 INFO - PROCESS | 27191 | __start_cc_report 19:23:55 INFO - PROCESS | 27191 | _x_x_mozilla_cycle_collect,318 19:23:55 INFO - PROCESS | 27191 | __end_cc_report 19:23:55 INFO - PROCESS | 27191 | __startTimestamp1452828235224__endTimestamp 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | ------- Summary: start ------- 19:23:55 INFO - PROCESS | 27191 | Number of tests: 6 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#0] dojo.html Cycles:165 Average:5232.51 Median:5463.67 stddev:561.54 (10.3%) stddev-sans-first:539.51 19:23:55 INFO - PROCESS | 27191 | Values: 3172.6 3212.0 3237.0 3252.9 3255.9 5093.4 5232.9 5241.4 5242.3 5256.9 5159.1 5216.2 5233.3 5258.6 5276.4 4733.4 4769.6 4802.0 4821.4 4878.9 4794.8 4816.8 4854.8 4867.6 4914.4 4756.2 4757.5 4823.7 4826.1 4838.1 4830.2 4837.6 4880.3 4883.1 4891.7 4843.3 4860.9 4867.1 4875.3 4877.3 4934.5 4951.5 5120.0 5192.6 5196.3 5623.9 5638.0 5649.2 5690.6 5694.5 5676.0 5679.9 5693.2 5705.7 5723.2 5138.3 5198.5 5297.1 5366.6 5400.9 5722.2 5726.0 5727.1 5732.9 5738.9 5375.6 5518.9 5528.2 5529.4 5533.8 5584.7 5609.3 5640.8 5655.2 5704.5 5555.4 5579.8 5590.3 5591.0 5596.9 5526.8 5530.0 5565.3 5590.6 5600.6 4327.2 4355.5 4359.2 4391.3 4396.6 3800.9 3851.4 3894.8 3911.7 3965.5 5136.6 5197.9 5275.3 5326.9 5374.2 5587.1 5630.9 5654.1 5664.7 5716.6 5203.6 5244.3 5245.2 5258.4 5314.4 4747.9 4815.6 4817.5 4830.8 4878.2 5803.9 5817.3 5825.1 5833.2 5852.2 5598.4 5601.6 5601.9 5604.0 5612.8 5763.2 5770.7 5772.9 5799.4 5851.4 5543.9 5544.1 5558.4 5559.1 5563.0 5466.4 5590.2 5633.0 5633.2 5652.7 5526.0 5532.4 5547.7 5585.5 5657.6 5494.5 5496.7 5512.3 5513.1 5519.8 5386.0 5406.7 5422.4 5463.7 5475.0 5482.1 5523.2 5537.3 5564.2 5566.3 5422.0 5429.1 5458.9 5465.2 5482.6 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#1] ext.html Cycles:180 Average:47003.42 Median:19507.06 stddev:87333.07 (447.7%) stddev-sans-first:87508.39 19:23:55 INFO - PROCESS | 27191 | Values: 542.2 554.3 578.7 591.7 592.6 27248.6 27857.6 35444.5 35793.0 35869.3 38787.0 39236.6 39354.6 39542.4 39585.2 8443.1 8594.0 8624.2 8624.4 8624.7 8384.2 8439.2 8475.8 8501.5 8505.0 8453.6 8584.7 8755.3 8760.3 8786.9 8634.3 8702.0 8719.9 8726.2 8727.7 8516.5 8635.9 8652.1 8652.8 8662.4 39663.0 39731.4 40078.2 40081.4 40140.6 3283.0 3455.6 3569.6 3622.2 3735.9 29472.7 29789.4 30259.1 30447.1 30682.4 3934.3 3958.0 3964.9 4028.5 4113.7 273135.0 274284.0 275649.0 275732.0 278152.0 41663.8 41716.8 42080.0 42245.4 52854.7 39713.8 39778.8 40042.8 40083.6 40099.8 15082.8 15194.9 15217.0 15217.4 15241.2 11779.1 11940.4 11988.7 12014.9 12224.9 14245.7 14259.2 14395.0 14395.1 14453.4 5577.4 5680.3 5697.4 5742.4 5760.8 917.8 942.4 983.9 1019.1 1028.0 28552.4 30779.2 30795.2 30944.0 31416.0 998.7 1012.9 1016.8 1030.4 1079.0 14294.4 14551.0 14842.8 14899.3 14930.0 420179.0 422350.0 430607.0 430647.0 431469.0 52934.2 53406.7 53407.9 53431.5 53915.0 1313.7 1327.1 1333.8 1333.9 1348.2 27679.9 28532.6 28555.7 28678.0 28833.4 45926.8 46369.3 46405.1 46664.3 46674.1 263187.0 265404.0 265826.0 266365.0 266456.0 27258.6 27752.7 30300.2 30775.5 31976.4 36346.8 36726.0 36818.8 37017.1 37298.4 31490.7 31631.8 31948.7 34844.3 35308.8 34059.8 34084.1 34279.0 34459.3 34754.8 33226.0 34069.3 34190.3 34411.8 34426.0 29272.6 31334.4 31441.0 31787.0 31912.2 23814.4 24116.2 24138.9 24226.3 24406.8 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#2] jquery.html Cycles:180 Average:24131.27 Median:4477.50 stddev:64083.13 (1431.2%) stddev-sans-first:64238.04 19:23:55 INFO - PROCESS | 27191 | Values: 361.8 362.5 362.9 363.0 369.4 15692.3 16174.3 16800.2 16810.4 17542.3 10200.6 10414.6 15421.5 15922.8 15930.5 5652.4 6035.2 6079.2 6096.8 6111.5 5935.7 5989.5 6029.8 6202.9 6470.4 6168.8 6405.1 6442.4 6444.3 6455.2 6368.5 6373.3 6386.0 6433.0 6743.5 6270.1 6381.0 6423.1 6438.1 6459.7 21359.5 21832.0 22023.4 22038.3 22412.9 2073.3 2164.7 2209.6 2348.8 2356.6 13284.2 13660.3 14000.3 14003.3 14112.0 1893.3 1907.4 1917.6 1962.6 1964.5 60283.7 62450.4 63141.4 63671.7 64455.7 14659.7 15154.4 15244.6 15255.5 15737.8 22878.5 23180.0 23349.4 23538.9 23576.4 7058.5 7331.7 7339.9 7380.4 9085.4 7369.3 7373.2 7374.4 7418.0 7463.3 4358.2 4420.8 4449.1 4453.5 4501.5 1745.2 1794.7 1818.5 1823.0 1829.4 912.7 956.3 961.4 961.5 974.1 15188.5 15592.6 16063.1 16388.0 16455.8 885.3 929.6 951.4 984.9 994.8 8890.0 9037.5 9062.6 9151.9 9302.7 373707.0 378923.0 382266.0 382562.0 430894.0 73032.6 73260.0 73525.6 74443.3 76361.6 1027.7 1064.5 1069.6 1070.4 1081.1 14189.8 14667.5 15008.4 15010.8 15039.3 28924.0 30374.0 31474.0 32604.2 32613.8 42722.2 42987.0 43097.0 44181.6 44469.8 6974.4 7015.8 7042.7 7054.3 7167.4 9787.6 10734.5 10900.1 11092.1 11488.0 7914.0 9017.0 9332.3 9383.4 9393.1 9153.2 9169.9 9414.2 9417.8 9517.1 9225.7 9779.6 10028.5 10055.3 10142.3 7424.0 7584.2 7623.5 7653.3 7658.2 8799.5 9364.3 9642.8 9667.5 9699.9 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#3] mootools.html Cycles:180 Average:5424.89 Median:6165.49 stddev:2811.92 (45.6%) stddev-sans-first:2803.42 19:23:55 INFO - PROCESS | 27191 | Values: 1386.9 1418.5 1533.5 1703.3 1716.3 7601.7 7627.8 7730.8 7772.2 7841.3 7867.3 7895.8 7903.4 7939.5 7964.8 2323.7 2347.6 2351.5 2352.7 2355.4 2350.9 2375.3 2375.7 2381.2 2384.2 2299.8 2316.7 2341.4 2345.6 2348.6 2284.6 2302.4 2333.2 2341.8 2341.8 2310.9 2315.3 2316.0 2328.1 2332.1 7446.4 7456.7 7494.5 7535.2 7538.8 4705.3 4784.4 4815.7 4846.5 4857.4 3081.2 3119.5 3156.2 3173.0 3207.2 1080.9 1084.1 1100.3 1103.6 1141.3 10590.9 10733.2 10815.8 10825.0 10839.0 4251.0 4303.7 4396.8 4456.2 4480.6 9193.4 9238.7 9252.6 9294.9 9302.9 4878.7 4897.3 4905.6 4926.8 4932.4 4441.4 4452.3 4471.2 4472.3 4487.2 3533.5 3653.2 3672.5 3674.4 3698.3 1116.6 1171.2 1198.6 1202.0 1208.5 976.4 988.9 1013.1 1093.2 1243.2 7072.2 7177.9 7188.3 7232.2 7240.1 619.4 627.6 629.1 631.4 758.0 5205.5 5268.2 5274.0 5282.6 5293.1 8926.6 9006.1 9423.5 9449.2 9637.5 9311.2 9364.3 9385.6 9469.1 9499.4 7292.8 7306.2 7462.7 7513.5 7513.8 7121.4 7129.9 7145.5 7147.0 7159.9 8176.6 8379.3 8459.7 8527.7 8553.8 8114.5 8291.3 8310.6 8323.0 8323.4 6911.0 6969.9 7059.4 7066.6 7079.1 7568.5 7613.4 7615.3 7620.9 7621.7 6804.9 6939.7 7167.6 7249.2 7282.7 6469.2 6503.9 6553.0 6590.1 6862.9 6506.0 6649.1 6659.2 6663.6 6754.2 6035.8 6044.5 6046.4 6116.7 6126.8 6038.6 6132.8 6144.7 6186.3 6230.3 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#4] prototype.html Cycles:180 Average:5635.76 Median:6313.14 stddev:1724.33 (27.3%) stddev-sans-first:1682.79 19:23:55 INFO - PROCESS | 27191 | Values: 343.5 344.2 348.6 349.3 355.8 6235.1 6312.7 6345.7 6348.4 6431.0 6267.5 6304.9 6320.1 6327.5 6353.8 4819.6 4841.0 4845.3 4850.2 4855.5 4842.4 4844.7 4848.1 4851.1 4851.5 4710.3 4783.6 4812.1 4813.4 4827.2 4796.5 4797.2 4801.1 4809.3 4820.2 4169.9 4187.1 4198.9 4199.1 4205.2 5989.2 6044.4 6071.3 6093.3 6097.3 5537.2 5622.9 5636.3 5640.5 5643.9 6739.0 6743.6 6750.7 6764.1 6768.5 4630.5 4634.1 4639.3 4641.7 4642.7 6872.8 6944.7 6987.2 6996.4 7019.3 4711.8 4716.5 4724.8 4726.1 4728.5 4733.4 4760.2 4792.5 4794.7 4802.6 5552.0 5564.1 5566.1 5572.9 5584.5 6507.3 6738.5 6739.5 6761.5 6763.9 1614.6 1619.3 1621.5 1624.5 1663.3 1110.3 1115.6 1124.3 1131.9 1139.2 6148.4 6181.6 6313.6 6327.2 6343.6 6901.8 6907.2 6931.0 6933.1 6947.1 6171.0 6301.5 6303.6 6306.8 6307.3 3724.8 3751.2 3753.6 3760.7 3767.2 7232.0 7239.7 7250.4 7257.2 7265.2 6958.3 7028.0 7056.4 7076.5 7082.6 7368.6 7380.3 7384.4 7393.7 7401.4 6999.2 7017.0 7050.1 7050.2 7060.6 6816.6 6892.4 6916.4 6942.9 6976.7 7309.7 7332.0 7353.6 7362.5 7382.2 4731.7 4749.0 4751.7 4752.4 4781.1 6830.9 6906.5 6977.5 7009.3 7065.1 6815.8 6839.5 6857.4 6866.4 6881.0 6814.8 6843.4 6844.8 6850.3 6853.6 6567.2 6686.3 6715.8 6719.9 6742.5 6870.7 6877.3 6891.2 6897.2 6902.5 6677.2 6693.7 6697.8 6705.0 6726.2 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - PROCESS | 27191 | [#5] yui.html Cycles:180 Average:13593.49 Median:45048.71 stddev:15565.47 (34.6%) stddev-sans-first:15579.15 19:23:55 INFO - PROCESS | 27191 | Values: 728.3 736.2 802.5 802.7 817.6 12643.4 12756.2 12791.6 12798.3 12843.8 13583.7 13813.7 13816.3 13861.0 13939.2 784.2 786.7 796.9 797.3 797.4 790.5 793.1 793.9 794.6 796.0 812.4 812.9 813.3 813.5 814.8 803.1 803.7 805.6 810.3 812.1 599.2 601.6 605.3 607.2 607.6 13208.9 13312.1 13325.8 13378.5 13402.7 12179.9 12252.0 12344.4 12489.2 12630.7 9958.6 10090.9 10144.5 10158.3 10307.2 3493.4 3526.0 3547.1 3628.1 3633.1 49210.8 49219.0 49241.5 49443.5 50622.0 8973.7 9207.9 9248.5 9296.9 9373.2 17573.0 17603.4 17628.8 17640.5 17658.6 7180.9 7278.0 7293.4 7503.4 7513.0 4175.1 4191.6 4212.9 4228.3 4235.2 3129.8 3149.0 3152.7 3174.3 3191.4 567.7 570.6 582.2 590.6 597.6 461.9 480.0 537.7 563.3 588.8 8182.0 8981.4 9107.9 9235.3 9444.8 520.3 539.6 544.3 596.6 659.6 3965.1 3987.6 4241.6 4249.4 4250.7 55235.4 55777.4 56065.0 56396.4 56506.0 47812.8 48544.3 48586.3 49403.3 49474.3 44415.3 44671.6 45004.3 45093.1 45099.5 8395.6 8444.8 8597.5 8600.6 9058.1 30773.2 33275.8 33744.5 33854.2 34537.0 43295.8 43313.8 43896.6 43983.6 44324.4 10247.7 10396.3 11025.8 11231.2 11253.0 12447.9 12457.3 12512.7 13078.5 13180.5 11148.6 11525.8 11537.8 11615.9 11731.9 10903.9 10943.2 11038.2 11899.9 12258.3 11321.4 11452.1 11604.4 11607.8 11656.4 9304.5 9510.8 9721.1 9912.5 10043.4 9646.3 9903.9 10009.4 10015.2 10108.1 19:23:55 INFO - PROCESS | 27191 | -------- Summary: end -------- 19:23:55 INFO - PROCESS | 27191 | 19:23:55 INFO - TEST-INFO | 27191: exit 0 19:23:55 INFO - TEST-OK | dromaeo_css | took 1109940ms 19:23:55 INFO - TEST-START | kraken 19:23:55 INFO - operating with platform_type : linux_ 19:23:55 INFO - Initialising browser for kraken test... 19:23:55 INFO - TEST-INFO | started process 27436 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfnd1JT/profile http://localhost:58806/getInfo.html) 19:23:59 INFO - PROCESS | 27436 | 19:23:59 INFO - PROCESS | 27436 | (process:27509): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:24:00 INFO - PROCESS | 27436 | __metrics Screen width/height:1600/1200 19:24:00 INFO - PROCESS | 27436 | colorDepth:24 19:24:00 INFO - PROCESS | 27436 | Browser inner width/height: 1024/697 19:24:00 INFO - PROCESS | 27436 | __metrics 19:24:00 INFO - PROCESS | 27436 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:24:01 INFO - TEST-INFO | 27436: exit 0 19:24:01 INFO - Browser initialized. 19:24:01 INFO - Running cycle 1/1 for kraken test... 19:24:01 INFO - TEST-INFO | started process 27558 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfnd1JT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:02 INFO - PROCESS | 27558 | 19:24:02 INFO - PROCESS | 27558 | (process:27617): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:24:12 INFO - PROCESS | 27558 | RSS: Main: 151113728 19:24:12 INFO - PROCESS | 27558 | 19:24:15 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58806/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:15 INFO - PROCESS | 27558 | RSS: Main: 151429120 19:24:15 INFO - PROCESS | 27558 | 19:24:18 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58806/tests/kraken/driver.html?testName=audio-dft) 19:24:19 INFO - PROCESS | 27558 | RSS: Main: 155095040 19:24:19 INFO - PROCESS | 27558 | 19:24:22 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58806/tests/kraken/driver.html?testName=audio-fft) 19:24:22 INFO - PROCESS | 27558 | RSS: Main: 147546112 19:24:22 INFO - PROCESS | 27558 | 19:24:25 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58806/tests/kraken/driver.html?testName=audio-oscillator) 19:24:25 INFO - PROCESS | 27558 | RSS: Main: 147525632 19:24:25 INFO - PROCESS | 27558 | 19:24:27 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58806/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:28 INFO - PROCESS | 27558 | RSS: Main: 147542016 19:24:28 INFO - PROCESS | 27558 | 19:24:31 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58806/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:32 INFO - PROCESS | 27558 | RSS: Main: 148877312 19:24:32 INFO - PROCESS | 27558 | 19:24:35 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58806/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:36 INFO - PROCESS | 27558 | RSS: Main: 149164032 19:24:36 INFO - PROCESS | 27558 | 19:24:38 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58806/tests/kraken/driver.html?testName=json-parse-financial) 19:24:39 INFO - PROCESS | 27558 | RSS: Main: 150470656 19:24:39 INFO - PROCESS | 27558 | 19:24:40 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58806/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:24:41 INFO - PROCESS | 27558 | RSS: Main: 150609920 19:24:41 INFO - PROCESS | 27558 | 19:24:43 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:24:43 INFO - PROCESS | 27558 | RSS: Main: 150982656 19:24:43 INFO - PROCESS | 27558 | 19:24:46 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:24:46 INFO - PROCESS | 27558 | RSS: Main: 150319104 19:24:46 INFO - PROCESS | 27558 | 19:24:49 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:24:49 INFO - PROCESS | 27558 | RSS: Main: 150736896 19:24:49 INFO - PROCESS | 27558 | 19:24:52 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:52 INFO - PROCESS | 27558 | RSS: Main: 151244800 19:24:52 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | Cycle 1(1): loaded http://localhost:58806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58806/tests/kraken/driver.html?testName=ai-astar) 19:24:54 INFO - PROCESS | 27558 | RSS: Main: 152543232 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | __start_tp_report 19:24:54 INFO - PROCESS | 27558 | _x_x_mozilla_page_load 19:24:54 INFO - PROCESS | 27558 | _x_x_mozilla_page_load_details 19:24:54 INFO - PROCESS | 27558 | |i|pagename|runs| 19:24:54 INFO - PROCESS | 27558 | |0;ai-astar;111;108;110;111;112;121;111;111;110;113 19:24:54 INFO - PROCESS | 27558 | |1;audio-beat-detection;155;138;154;172;134;156;155;134;159;127 19:24:54 INFO - PROCESS | 27558 | |2;audio-dft;163;164;163;163;164;163;162;166;170;163 19:24:54 INFO - PROCESS | 27558 | |3;audio-fft;75;72;74;76;74;73;75;137;72;73 19:24:54 INFO - PROCESS | 27558 | |4;audio-oscillator;96;96;138;97;97;97;142;98;97;142 19:24:54 INFO - PROCESS | 27558 | |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;109;110 19:24:54 INFO - PROCESS | 27558 | |6;imaging-darkroom;146;148;148;146;147;146;146;147;147;148 19:24:54 INFO - PROCESS | 27558 | |7;imaging-desaturate;97;97;96;97;97;97;96;95;96;97 19:24:54 INFO - PROCESS | 27558 | |8;json-parse-financial;58;58;60;62;60;60;60;61;57;58 19:24:54 INFO - PROCESS | 27558 | |9;json-stringify-tinderbox;68;74;69;68;69;71;71;69;69;69 19:24:54 INFO - PROCESS | 27558 | |10;stanford-crypto-aes;89;83;85;83;92;81;82;82;90;92 19:24:54 INFO - PROCESS | 27558 | |11;stanford-crypto-ccm;115;119;129;131;118;114;120;116;121;123 19:24:54 INFO - PROCESS | 27558 | |12;stanford-crypto-pbkdf2;145;144;145;144;136;149;142;143;142;148 19:24:54 INFO - PROCESS | 27558 | |13;stanford-crypto-sha256-iterative;67;65;66;68;65;68;72;66;66;66 19:24:54 INFO - PROCESS | 27558 | __end_tp_report 19:24:54 INFO - PROCESS | 27558 | __start_cc_report 19:24:54 INFO - PROCESS | 27558 | _x_x_mozilla_cycle_collect,724 19:24:54 INFO - PROCESS | 27558 | __end_cc_report 19:24:54 INFO - PROCESS | 27558 | __startTimestamp1452828294730__endTimestamp 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | ------- Summary: start ------- 19:24:54 INFO - PROCESS | 27558 | Number of tests: 14 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:3.49 (3.1%) stddev-sans-first:3.69 19:24:54 INFO - PROCESS | 27558 | Values: 111.0 108.0 110.0 111.0 112.0 121.0 111.0 111.0 110.0 113.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:155.00 stddev:14.25 (9.2%) stddev-sans-first:14.91 19:24:54 INFO - PROCESS | 27558 | Values: 155.0 138.0 154.0 172.0 134.0 156.0 155.0 134.0 159.0 127.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.33 (1.4%) stddev-sans-first:2.44 19:24:54 INFO - PROCESS | 27558 | Values: 163.0 164.0 163.0 163.0 164.0 163.0 162.0 166.0 170.0 163.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#3] audio-fft Cycles:10 Average:80.10 Median:74.00 stddev:20.04 (27.1%) stddev-sans-first:21.17 19:24:54 INFO - PROCESS | 27558 | Values: 75.0 72.0 74.0 76.0 74.0 73.0 75.0 137.0 72.0 73.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:97.00 stddev:21.20 (21.9%) stddev-sans-first:21.87 19:24:54 INFO - PROCESS | 27558 | Values: 96.0 96.0 138.0 97.0 97.0 97.0 142.0 98.0 97.0 142.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:24:54 INFO - PROCESS | 27558 | Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 19:24:54 INFO - PROCESS | 27558 | Values: 146.0 148.0 148.0 146.0 147.0 146.0 146.0 147.0 147.0 148.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 19:24:54 INFO - PROCESS | 27558 | Values: 97.0 97.0 96.0 97.0 97.0 97.0 96.0 95.0 96.0 97.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:1.58 (2.6%) stddev-sans-first:1.59 19:24:54 INFO - PROCESS | 27558 | Values: 58.0 58.0 60.0 62.0 60.0 60.0 60.0 61.0 57.0 58.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:1.83 (2.7%) stddev-sans-first:1.83 19:24:54 INFO - PROCESS | 27558 | Values: 68.0 74.0 69.0 68.0 69.0 71.0 71.0 69.0 69.0 69.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:87.00 stddev:4.38 (5.0%) stddev-sans-first:4.50 19:24:54 INFO - PROCESS | 27558 | Values: 89.0 83.0 85.0 83.0 92.0 81.0 82.0 82.0 90.0 92.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#11] stanford-crypto-ccm Cycles:10 Average:120.60 Median:120.50 stddev:5.68 (4.7%) stddev-sans-first:5.65 19:24:54 INFO - PROCESS | 27558 | Values: 115.0 119.0 129.0 131.0 118.0 114.0 120.0 116.0 121.0 123.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:144.50 stddev:3.58 (2.5%) stddev-sans-first:3.77 19:24:54 INFO - PROCESS | 27558 | Values: 145.0 144.0 145.0 144.0 136.0 149.0 142.0 143.0 142.0 148.0 19:24:54 INFO - PROCESS | 27558 | 19:24:54 INFO - PROCESS | 27558 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.20 19:24:54 INFO - PROCESS | 27558 | Values: 67.0 65.0 66.0 68.0 65.0 68.0 72.0 66.0 66.0 66.0 19:24:54 INFO - PROCESS | 27558 | -------- Summary: end -------- 19:24:54 INFO - PROCESS | 27558 | 19:24:55 INFO - TEST-INFO | 27558: exit 0 19:24:55 INFO - TEST-OK | kraken | took 59889ms 19:24:55 INFO - TEST-START | v8_7 19:24:55 INFO - operating with platform_type : linux_ 19:24:55 INFO - Initialising browser for v8_7 test... 19:24:55 INFO - TEST-INFO | started process 27846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvSgZOk/profile http://localhost:58806/getInfo.html) 19:24:59 INFO - PROCESS | 27846 | 19:24:59 INFO - PROCESS | 27846 | (process:27918): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:25:00 INFO - PROCESS | 27846 | __metrics Screen width/height:1600/1200 19:25:00 INFO - PROCESS | 27846 | colorDepth:24 19:25:00 INFO - PROCESS | 27846 | Browser inner width/height: 1024/697 19:25:00 INFO - PROCESS | 27846 | __metrics 19:25:00 INFO - PROCESS | 27846 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:25:01 INFO - TEST-INFO | 27846: exit 0 19:25:01 INFO - Browser initialized. 19:25:01 INFO - Running cycle 1/1 for v8_7 test... 19:25:01 INFO - TEST-INFO | started process 27967 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvSgZOk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:02 INFO - PROCESS | 27967 | 19:25:02 INFO - PROCESS | 27967 | (process:28023): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:25:13 INFO - PROCESS | 27967 | RSS: Main: 151068672 19:25:13 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | Cycle 1(1): loaded http://localhost:58806/tests/v8_7/run.html (next: http://localhost:58806/tests/v8_7/run.html) 19:25:35 INFO - PROCESS | 27967 | RSS: Main: 146173952 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | __start_tp_report 19:25:35 INFO - PROCESS | 27967 | _x_x_mozilla_page_load 19:25:35 INFO - PROCESS | 27967 | _x_x_mozilla_page_load_details 19:25:35 INFO - PROCESS | 27967 | |i|pagename|runs| 19:25:35 INFO - PROCESS | 27967 | |0;Richards;167.5603217158177 19:25:35 INFO - PROCESS | 27967 | |1;DeltaBlue;188.040616773223 19:25:35 INFO - PROCESS | 27967 | |2;Encrypt;279.9552071668533 19:25:35 INFO - PROCESS | 27967 | |3;Decrypt;5218.75 19:25:35 INFO - PROCESS | 27967 | |4;RayTrace;1067.2358591248667 19:25:35 INFO - PROCESS | 27967 | |5;Earley;716.0228898426324 19:25:35 INFO - PROCESS | 27967 | |6;Boyer;12419.753086419752 19:25:35 INFO - PROCESS | 27967 | |7;RegExp;41260 19:25:35 INFO - PROCESS | 27967 | |8;Splay;625.3908692933084 19:25:35 INFO - PROCESS | 27967 | |9;NavierStokes;4845.410628019324 19:25:35 INFO - PROCESS | 27967 | __end_tp_report 19:25:35 INFO - PROCESS | 27967 | __startTimestamp1452828335757__endTimestamp 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | ------- Summary: start ------- 19:25:35 INFO - PROCESS | 27967 | Number of tests: 10 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#0] Richards Cycles:1 Average:167.56 Median:167.56 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 167.6 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#1] DeltaBlue Cycles:1 Average:188.04 Median:188.04 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 188.0 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 280.0 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 5218.8 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 1067.2 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#5] Earley Cycles:1 Average:716.02 Median:716.02 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 716.0 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 12419.8 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#7] RegExp Cycles:1 Average:41260.00 Median:41260.00 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 41260.0 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#8] Splay Cycles:1 Average:625.39 Median:625.39 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 625.4 19:25:35 INFO - PROCESS | 27967 | 19:25:35 INFO - PROCESS | 27967 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 27967 | Values: 4845.4 19:25:35 INFO - PROCESS | 27967 | -------- Summary: end -------- 19:25:35 INFO - PROCESS | 27967 | 19:25:36 INFO - TEST-INFO | 27967: exit 0 19:25:36 INFO - TEST-OK | v8_7 | took 40882ms 19:25:36 INFO - SUITE-END | took 1210s 19:25:36 INFO - Completed test suite (00:20:10) 19:25:36 INFO - Working with test: dromaeo_css 19:25:36 INFO - Generating results file: dromaeo_css 19:25:36 INFO - Working with test: kraken 19:25:36 INFO - Generating results file: kraken 19:25:36 INFO - javascript benchmark 19:25:36 INFO - Working with test: v8_7 19:25:36 INFO - Generating results file: v8_7 19:25:36 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:25:36 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 19:25:36 INFO - process_Request line: dromaeo_css 6908.28 graph.html#tests=[[72,64,43]] 19:25:36 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:25:36 INFO - process_Request line: kraken 1513.90 graph.html#tests=[[232,64,43]] 19:25:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:25:37 INFO - process_Request line: v8_7 20247.82 graph.html#tests=[[230,64,43]] 19:25:37 INFO - RETURN: dromaeo_css: 6908.28 19:25:37 INFO - RETURN: kraken: 1513.90 19:25:37 INFO - RETURN: v8_7: 20247.82 19:25:37 INFO - javascript benchmark 19:25:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3172.5875636167293, 3211.951820722688, 3236.983815080924, 3252.8861489847855, 3255.8534865931033, 5093.439721630618, 5232.947670523294, 5241.42344342122, 5242.344706911631, 5256.92114618281, 5159.071367153921, 5216.191490319006, 5233.267342572033, 5258.6318957672975, 5276.366835979678, 4733.384659994204, 4769.642276829234, 4801.951980480186, 4821.373221481203, 4878.878028049309, 4794.760261986887, 4816.783244753994, 4854.8300809471675, 4867.610591152717, 4914.410270767513, 4756.191447453941, 4757.452892917324, 4823.710577365352, 4826.131296366652, 4838.129136755382, 4830.2030165022725, 4837.637177211688, 4880.292357608162, 4883.096627123993, 4891.657583969123, 4843.321934929113, 4860.878478038042, 4867.050925069613, 4875.34182885313, 4877.268409738532, 4934.506549345073, 4951.5048495150195, 5120.02719483297, 5192.584593232532, 5196.29849970253, 5623.8594035149445, 5638.0, 5649.180868774046, 5690.60165788395, 5694.544436445074, 5676.0, 5679.886402271973, 5693.202951586781, 5705.657660540381, 5723.227364305807, 5138.2806407103035, 5198.506141916512, 5297.099493086184, 5366.6243362964215, 5400.891982160374, 5722.17028530869, 5726.026575482178, 5727.083666613322, 5732.914006289909, 5738.913916291259, 5375.596830237748, 5518.944810551923, 5528.170774383874, 5529.447055294519, 5533.806316778893, 5584.692841893653, 5609.326880774333, 5640.7743690252755, 5655.179998900218, 5704.515116215085, 5555.416681248492, 5579.804706835242, 5590.273264475673, 5591.0, 5596.944030559724, 5526.806561770319, 5529.972350138223, 5565.276514053147, 5590.580706446952, 5600.5799565032785, 4327.242732521859, 4355.499117601453, 4359.215341238544, 4391.3193455014525, 4396.648268138605, 3800.8859734208017, 3851.4030325299623, 3894.824732887027, 3911.7457365271166, 3965.464662270614, 5136.5890728741615, 5197.908439227805, 5275.261463395128, 5326.92009619856, 5374.220737992969, 5587.1339942309005, 5630.859228519238, 5654.06707893193, 5664.660120392789, 5716.57125715573, 5203.583713302926, 5244.29202057725, 5245.160774276097, 5258.421573626898, 5314.441983591667, 4747.8575642730775, 4815.6388270879825, 4817.470078291385, 4830.806767729251, 4878.195097808893, 5803.9419605803405, 5817.3019237690905, 5825.0679891217205, 5833.183354330397, 5852.15143804146, 5598.384177740364, 5601.579881508822, 5601.859953501032, 5604.047311956896, 5612.775488980558, 5763.221965034667, 5770.682612456188, 5772.913406298993, 5799.391063938226, 5851.385604511635, 5543.8891222176135, 5544.057510223352, 5558.44415558441, 5559.11054231321, 5562.972185139049, 5466.4260252674485, 5590.2453168821685, 5632.971835140798, 5633.1831884375715, 5652.68910209926, 5525.972370138124, 5532.419095994863, 5547.722613869209, 5585.5252303553025, 5657.575681823962, 5494.478024587658, 5496.725163741717, 5512.310961129859, 5513.117901135799, 5519.806806761744, 5386.030514507426, 5406.702631355313, 5422.403535611158, 5463.672179669233, 5474.972625136849, 5482.068048431696, 5523.171524271392, 5537.307836520435, 5564.165375193753, 5566.332040155207, 5422.024035673617, 5429.131338985743, 5458.890822183614, 5465.207544905887, 5482.588805839658], "unit": "score", "name": "dojo.html", "value": 5197.51297929147}, {"lowerIsBetter": false, "replicates": [542.1975476295083, 554.2517601238329, 578.7222133375982, 591.7159763313609, 592.5851903667433, 27248.63756812159, 27857.58213626797, 35444.468332975026, 35793.0, 35869.2826143477, 38787.0, 39236.60763392365, 39354.606453935456, 39542.40686389699, 39585.20829583414, 8443.071262161142, 8594.0, 8624.180702833251, 8624.35317351198, 8624.65501379944, 8384.203500667427, 8439.240468357846, 8475.788105297386, 8501.489910605353, 8504.957475212646, 8453.577321133918, 8584.656613735444, 8755.299576033902, 8760.342974276955, 8786.912130878705, 8634.266087382548, 8702.042775294713, 8719.869201961976, 8726.214640682305, 8727.694530691428, 8516.489010659318, 8635.913640863573, 8652.134786521297, 8652.82694346116, 8662.436941598839, 39663.0, 39731.4040289393, 40078.19843603141, 40081.39877901834, 40140.59859401427, 3282.983585082083, 3455.568053993251, 3569.6430356964356, 3622.1669016126175, 3735.8505659773577, 29472.70527294721, 29789.40421191586, 30259.092227233217, 30447.086587402413, 30682.386352273053, 3934.272159650474, 3957.980210098931, 3964.86122985697, 4028.4561584186054, 4113.691473139496, 273135.0, 274284.0, 275649.0, 275731.999999998, 278152.0, 41663.79168104201, 41716.791416042724, 42080.0, 42245.36631950462, 52854.73572632112, 39713.80143099266, 39778.80110599429, 40042.799786001466, 40083.59916400857, 40099.79950100231, 15082.849171508144, 15194.924025379802, 15217.0, 15217.391304347924, 15241.23793810305, 11779.116566257566, 11940.402979850973, 11988.700282493008, 12014.879851201551, 12224.938875305566, 14245.715085698228, 14259.21574313402, 14395.0, 14395.136291822524, 14453.421863125357, 5577.358603760619, 5680.346760122638, 5697.373288938214, 5742.425757424307, 5760.8271751847515, 917.7881306052515, 942.4298299528823, 983.9262055345878, 1019.0777346501428, 1028.0, 28552.428951420854, 30779.230519237197, 30795.230119247197, 30944.0, 31416.0, 998.7353351361895, 1012.9240306977006, 1016.8068067067234, 1030.4023666273692, 1078.9730256743487, 14294.356753945889, 14550.981431299919, 14842.777358339634, 14899.255037248095, 14930.0, 420179.0, 422350.0, 430607.0, 430647.0, 431469.0, 52934.20598691023, 53406.73296633492, 53407.92624700647, 53431.46568534343, 53915.0, 1313.7175507265983, 1327.1307293722627, 1333.8065980432978, 1333.8666133386778, 1348.1843484691817, 27679.861600691867, 28532.57201141943, 28555.714442855304, 28678.0, 28833.42333153367, 45926.77036614795, 46369.30446043379, 46405.07189856117, 46664.30003549882, 46674.066518670115, 263187.0, 265404.0, 265826.0, 266365.0, 266456.0, 27258.591121132802, 27752.722472775014, 30300.24249393783, 30775.53836692496, 31976.360472789947, 36346.81826590956, 36726.0, 36818.81590592137, 37017.074573135884, 37298.440523391626, 31490.685093148775, 31631.84184079065, 31948.6805131955, 34844.303113938084, 35308.82345588256, 34059.82970085134, 34084.1478963018, 34279.0, 34459.310813783086, 34754.82622586871, 33226.0, 34069.318613628086, 34190.31619367649, 34411.82794086014, 34426.0, 29272.56091158592, 31334.373312533167, 31441.0, 31787.0, 31912.202194944384, 23814.404639883447, 24116.247874457138, 24138.87930560336, 24226.273211803673, 24406.75593244116], "unit": "score", "name": "ext.html", "value": 17568.354141961954}, {"lowerIsBetter": false, "replicates": [361.76304520539037, 362.49251048532057, 362.88206332941786, 362.95644522657284, 369.3591618541828, 15692.293846776894, 16174.2721577529, 16800.159992000412, 16810.411635592758, 17542.298308067693, 10200.642977495789, 10414.63548775791, 15421.537353879374, 15922.76115858263, 15930.522084337488, 5652.406497317774, 6035.155078289043, 6079.179310793031, 6096.847578810521, 6111.511079113682, 5935.732892019848, 5989.520838332923, 6029.849253768647, 6202.9379706203035, 6470.385313395243, 6168.75324987, 6405.103285540028, 6442.420182183602, 6444.323346048668, 6455.193100862392, 6368.458681012119, 6373.298937116913, 6385.999999999976, 6432.967835160841, 6743.494237932175, 6270.122182894398, 6381.0, 6423.100765892778, 6438.066480360369, 6459.741610335581, 21359.466013349636, 21832.0, 22023.449413764785, 22038.33884983453, 22412.88793556022, 2073.2950796729033, 2164.675298705207, 2209.55808838233, 2348.7533808949984, 2356.552255071531, 13284.202947823162, 13660.316984150852, 14000.299985000811, 14003.299835008209, 14112.0, 1893.2710906301036, 1907.3961168032247, 1917.570412347468, 1962.5682349883002, 1964.479412955568, 60283.69858150725, 62450.37549624491, 63141.36858631447, 63671.68164159196, 64455.67772161109, 14659.727662377158, 15154.393824246907, 15244.618884527976, 15255.466058687893, 15737.763933541006, 22878.542429151323, 23180.0, 23349.416264593183, 23538.882305588362, 23576.410589735395, 7058.470614703918, 7331.716949533917, 7339.926600733925, 7380.372668323145, 9085.364024518352, 7369.263073692695, 7373.225811289844, 7374.410047196211, 7418.035655364876, 7463.275904294893, 4358.150160718629, 4420.756858372756, 4449.132419178294, 4453.51011388747, 4501.48232953208, 1745.171043754232, 1794.7218181181938, 1818.509002569299, 1822.9726554101699, 1829.3962992212537, 912.7216199059218, 956.3257903178243, 961.4137968863735, 961.4711908450324, 974.1476208317722, 15188.544343669708, 15592.610184745472, 16063.11652859104, 16388.0, 16455.83544164543, 885.2608072259735, 929.6188562689265, 951.4338968313842, 984.8818141823027, 994.7662299359645, 8889.955550222208, 9037.457752534869, 9062.592183351633, 9151.901771787296, 9302.720918372459, 373707.0, 378923.0, 382266.0, 382562.0, 430894.0, 73032.63483682547, 73260.0, 73525.63237183887, 74443.25556744472, 76361.61819190868, 1027.701966429742, 1064.462446464546, 1069.6363236499471, 1070.3577853287966, 1081.1350919264557, 14189.787153192505, 14667.48663796762, 15008.399664013317, 15010.77483837765, 15039.323230454436, 28924.0, 30374.0, 31474.0, 32604.184895376857, 32613.836930815192, 42722.223055501294, 42987.0, 43097.0, 44181.55818441774, 44469.77765111154, 6974.37230649244, 7015.754448594274, 7042.718291268292, 7054.259302773135, 7167.426605871622, 9787.608495660093, 10734.516946737573, 10900.127989760958, 11092.112630989663, 11488.0, 7914.0, 9016.954915225382, 9332.313736074348, 9383.436993780395, 9393.107654773059, 9153.17621414076, 9169.908300916906, 9414.199793017397, 9417.764555886157, 9517.143457088896, 9225.677101301422, 9779.559919803769, 10028.548715307683, 10055.346402483816, 10142.340747851365, 7424.0, 7584.241575842592, 7623.542587444771, 7653.311201991847, 7658.234176582298, 8799.47203167812, 9364.297677674065, 9642.758931026781, 9667.468289243878, 9699.884513281064], "unit": "score", "name": "jquery.html", "value": 8566.986794906668}, {"lowerIsBetter": false, "replicates": [1386.9375878085484, 1418.531884478122, 1533.5246073717142, 1703.2846204594084, 1716.270585001375, 7601.695932162714, 7627.80930476737, 7730.768076957694, 7772.222777722232, 7841.294283514482, 7867.331276841475, 7895.8420831583335, 7903.407244456675, 7939.483933544316, 7964.840703185947, 2323.732770731362, 2347.647852822073, 2351.5414494173556, 2352.7411984681758, 2355.3993731598416, 2350.9294721158394, 2375.251795684354, 2375.679283296759, 2381.1784934197763, 2384.248961577098, 2299.839011269212, 2316.6872472216287, 2341.4146463384154, 2345.589521833681, 2348.612478940973, 2284.565932472825, 2302.4013756423283, 2333.2416964486524, 2341.7892389684926, 2341.8360714749974, 2310.9422264443524, 2315.282262498614, 2316.027268547214, 2328.092044102801, 2332.137109269564, 7446.441516886255, 7456.701731930716, 7494.475386722877, 7535.171131175566, 7538.8115297117465, 4705.270683044099, 4784.425868895755, 4815.66290359675, 4846.515348465161, 4857.417109946829, 3081.229692576856, 3119.485284927984, 3156.2425017995515, 3173.0, 3207.1982004498877, 1080.9414523163753, 1084.1164450972433, 1100.312304809494, 1103.564092183591, 1141.3323205924462, 10590.894091059068, 10733.195010374253, 10815.782764533331, 10824.971627695435, 10839.0, 4250.957490425056, 4303.677224208197, 4396.780160991938, 4456.17560751262, 4480.551944805494, 9193.356465047516, 9238.67664631748, 9252.629894804133, 9294.86057709135, 9302.930163031202, 4878.707277563358, 4897.338859254026, 4905.607551395879, 4926.802927882916, 4932.383452068491, 4441.400410944481, 4452.332150177499, 4471.23988921884, 4472.2620767573635, 4487.214737420938, 3533.452314891196, 3653.159773252167, 3672.5042119314085, 3674.356987527172, 3698.2973235085788, 1116.5924437580225, 1171.1860257121218, 1198.5505435461703, 1201.9759604807855, 1208.528673817212, 976.3751199232497, 988.9109980101825, 1013.1337706261188, 1093.191038631407, 1243.2043492165021, 7072.222055573883, 7177.89233161503, 7188.281171882874, 7232.20445750967, 7240.05879235696, 619.3837132053545, 627.6077451592755, 629.134939458245, 631.4127861089231, 757.9848403032018, 5205.453427390145, 5268.2097685346735, 5273.973630131824, 5282.603804714662, 5293.12663410533, 8926.553672316359, 9006.144416280444, 9423.481708506099, 9449.196818270386, 9637.518124093767, 9311.208547273422, 9364.34449588536, 9385.57764900581, 9469.14777670013, 9499.38254013487, 7292.781216563511, 7306.232845551247, 7462.738804141937, 7513.47405681608, 7513.812154696177, 7121.430285577245, 7129.857402852018, 7145.535540189871, 7147.0, 7159.8568028640175, 8176.591170441335, 8379.329653627574, 8459.661613535636, 8527.701530446404, 8553.82892342162, 8114.513129212266, 8291.33669306442, 8310.626021828912, 8322.958385208036, 8323.41736078493, 6910.965445172742, 6969.895451568332, 7059.435245180476, 7066.646667666699, 7079.079719636415, 7568.508046977149, 7613.390928725799, 7615.314621684075, 7620.885686714814, 7621.733239336597, 6804.9319506804295, 6939.653017349011, 7167.605781682058, 7249.202587715453, 7282.708691652275, 6469.159009328757, 6503.902441463287, 6553.0, 6590.143281373391, 6862.862742745217, 6506.0, 6649.069130321662, 6659.167604049494, 6663.566868153554, 6754.223264324665, 6035.818925432244, 6044.486218671462, 6046.395360463918, 6116.694165291807, 6126.816195514141, 6038.63768173911, 6132.754689812536, 6144.692765361803, 6186.288576813724, 6230.283517395557], "unit": "score", "name": "mootools.html", "value": 4424.6673440944205}, {"lowerIsBetter": false, "replicates": [343.5259342107891, 344.2478185165414, 348.60259304392997, 349.34323471872875, 355.79363968898036, 6235.095911092894, 6312.652804095773, 6345.650989195592, 6348.428641422271, 6431.0, 6267.467265282445, 6304.936950630492, 6320.11518387425, 6327.525435592326, 6353.841153971153, 4819.590334821544, 4840.9757951210195, 4845.3216549683075, 4850.199717046683, 4855.465898751135, 4842.394700662418, 4844.660873738822, 4848.127337079324, 4851.102546028978, 4851.490593487686, 4710.26990816424, 4783.593394561449, 4812.10975969445, 4813.350197723297, 4827.155247831633, 4796.52034796521, 4797.184478638605, 4801.063792560452, 4809.254565542346, 4820.156472617278, 4169.854055108057, 4187.14163596462, 4198.874033778991, 4199.097194103252, 4205.158968206371, 5989.221401217857, 6044.365341639109, 6071.301800292978, 6093.268807743099, 6097.3292937776805, 5537.224788529609, 5622.859428514279, 5636.267285252891, 5640.464155905223, 5643.943560564383, 6738.966305168492, 6743.5953842769595, 6750.662466876685, 6764.0530325754435, 6768.458523318172, 4630.513796051399, 4634.050019745978, 4639.257718765015, 4641.675082744209, 4642.698224615389, 6872.793816185523, 6944.7222111116, 6987.196472405688, 6996.370326670624, 7019.333163349474, 4711.8350857719815, 4716.528347165325, 4724.811007559728, 4726.078414709099, 4728.4798672146035, 4733.360996265529, 4760.166970780099, 4792.520747925179, 4794.712317260975, 4802.615790736732, 5552.0, 5564.054110801174, 5566.053770858964, 5572.944270557324, 5584.497395234448, 6507.349265073455, 6738.460923126138, 6739.494537909676, 6761.492888033319, 6763.864722705518, 1614.6124930016947, 1619.295606411215, 1621.4568119679805, 1624.4720465848648, 1663.25984936702, 1110.2616759854768, 1115.6262652011505, 1124.2636073371955, 1131.9151063670092, 1139.1797905508022, 6148.354422785543, 6181.598196117238, 6313.621182729051, 6327.240731112204, 6343.5876668016435, 6901.827454313682, 6907.240203577602, 6930.965345173343, 6933.1333583302085, 6947.062146610244, 6171.0, 6301.464375528131, 6303.6217826929615, 6306.8423289417215, 6307.3377295383325, 3724.776513409204, 3751.249750050001, 3753.5871054184563, 3760.7367484275837, 3767.208886133888, 7231.963840180765, 7239.674214660353, 7250.4199664026755, 7257.237990011078, 7265.2371500992695, 6958.3041695831025, 7028.0, 7056.400205982549, 7076.4692648051605, 7082.610456424946, 7368.594727289943, 7380.298871607189, 7384.409247260206, 7393.741219057307, 7401.407887368998, 6999.230084690578, 7017.017617533447, 7050.118735158106, 7050.15398152225, 7060.611666358194, 6816.591004539743, 6892.379685828299, 6916.377526022682, 6942.8611427772175, 6976.651167441709, 7309.707611695472, 7331.963340183265, 7353.5955522446775, 7362.484626076123, 7382.224866389167, 4731.668783185144, 4748.976255118702, 4751.667383283275, 4752.405949256343, 4781.091592597395, 6830.93169068303, 6906.482013848881, 6977.511574189758, 7009.2990700929495, 7065.116860392451, 6815.761448349284, 6839.521233513607, 6857.382835544825, 6866.382025617719, 6881.036654868422, 6814.829629259309, 6843.418309443753, 6844.794656160323, 6850.280720524273, 6853.588784672936, 6567.2447668518735, 6686.29793871656, 6715.764948226984, 6719.932800671931, 6742.528023038536, 6870.656467176521, 6877.346652068046, 6891.173059232924, 6897.172339319314, 6902.482313826383, 6677.198736151693, 6693.665316734241, 6697.7655782047395, 6704.966475167593, 6726.217552348729], "unit": "score", "name": "prototype.html", "value": 5068.809320612624}, {"lowerIsBetter": false, "replicates": [728.3444899590364, 736.2232844349213, 802.502448481941, 802.6709049289789, 817.636151912399, 12643.431045602947, 12756.23462592244, 12791.552295669653, 12798.296093714842, 12843.80734288984, 13583.660408489768, 13813.654658633539, 13816.309184540783, 13861.029727919049, 13939.163650180997, 784.2197013971107, 786.6892577431911, 796.8565658181525, 797.2784629909941, 797.4417907464768, 790.5217343507153, 793.1037927142321, 793.9444238903279, 794.6106407860136, 796.0129439495042, 812.3501199040774, 812.8861959325699, 813.3330668851544, 813.5240884082789, 814.7515007922581, 803.0844836885955, 803.694596053496, 805.5529181304373, 810.266708628692, 812.0823469479479, 599.2269971736455, 601.6179725874058, 605.267626172332, 607.1560530862105, 607.5564837668527, 13208.933955330162, 13312.134711243738, 13325.800112998313, 13378.464861405531, 13402.731945361136, 12179.878201217964, 12252.0, 12344.382780861011, 12489.18820276679, 12630.684232894158, 9958.551865166084, 10090.899091009069, 10144.543495542719, 10158.28891977562, 10307.226957978182, 3493.371193185226, 3526.0, 3547.1486843157713, 3628.1473853644375, 3633.1462106404974, 49210.7539462304, 49219.0, 49241.50758492405, 49443.50556494425, 50622.0, 8973.730788076367, 9207.907920920705, 9248.491332976751, 9296.8605470918, 9373.1564159226, 17573.0, 17603.383881564085, 17628.823711762976, 17640.470785876445, 17658.646827063643, 7180.856382872418, 7277.963610181915, 7293.416526677853, 7503.437242206856, 7512.962435187789, 4175.102352994121, 4191.560263611382, 4212.873613791591, 4228.323468245066, 4235.237657221668, 3129.8435078246, 3148.9685103148677, 3152.6689697581883, 3174.2857856981996, 3191.377681352114, 567.6508946997649, 570.5749216833402, 582.1965687351428, 590.5895402695086, 597.6354423801478, 461.87067621066154, 480.0, 537.7069497124077, 563.2902542796106, 588.8135407154587, 8182.0, 8981.416207946462, 9107.908920910706, 9235.307351948497, 9444.811103777885, 520.282010825059, 539.5602583894114, 544.3292451012812, 596.6211455725645, 659.5548005096541, 3965.1276719121747, 3987.5613682494904, 4241.597048280409, 4249.447571815706, 4250.72370295936, 55235.44764552303, 55777.44222557804, 56065.0, 56396.43603563912, 56506.0, 47812.760936195096, 48544.27183592249, 48586.27120593194, 49403.258951115764, 49474.25788613174, 44415.33376999348, 44671.55328446739, 45004.324935126, 45093.09813803771, 45099.54900451019, 8395.580220989048, 8444.788880278042, 8597.52713600758, 8600.612972416382, 9058.094190581152, 30773.23066923255, 33275.83362083271, 33744.49383259204, 33854.153646159044, 34537.0, 43295.783521082194, 43313.783431082644, 43896.56103439053, 43983.560164397946, 44324.41051603588, 10247.692569222936, 10396.272260941661, 11025.779484410426, 11231.15766317513, 11253.043491303331, 12447.93776031114, 12457.252564846138, 12512.687182820502, 13078.476860925457, 13180.538681146114, 11148.554057837595, 11525.769484610428, 11537.769244614892, 11615.941920290345, 11731.88268117342, 10903.890961090288, 10943.179261555575, 11038.17213708959, 11899.881001189877, 12258.26450412978, 11321.377324246916, 11452.14108941816, 11604.42987366086, 11607.76784464323, 11656.417179141179, 9304.488253146143, 9510.762230944281, 9721.125098740864, 9912.542257945595, 10043.4476103815, 9646.276529260193, 9903.900960990586, 10009.399436033862, 10015.24885633595, 10108.1408080314], "unit": "score", "name": "yui.html", "value": 6194.99252900209}], "name": "dromaeo_css", "value": 6908.275329239108}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 110.0, 111.0, 112.0, 121.0, 111.0, 111.0, 110.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [155.0, 138.0, 154.0, 172.0, 134.0, 156.0, 155.0, 134.0, 159.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 163.0, 164.0, 163.0, 162.0, 166.0, 170.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 74.0, 76.0, 74.0, 73.0, 75.0, 137.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 97.0, 97.0, 97.0, 142.0, 98.0, 97.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 148.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 57.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 74.0, 69.0, 68.0, 69.0, 71.0, 71.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [89.0, 83.0, 85.0, 83.0, 92.0, 81.0, 82.0, 82.0, 90.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [115.0, 119.0, 129.0, 131.0, 118.0, 114.0, 120.0, 116.0, 121.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.6}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 144.0, 136.0, 149.0, 142.0, 143.0, 142.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 68.0, 65.0, 68.0, 72.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1513.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.5603217158177], "unit": "score", "name": "Richards", "value": 210.68233600000002}, {"lowerIsBetter": false, "replicates": [188.040616773223], "unit": "score", "name": "DeltaBlue", "value": 351.6155239999999}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [716.0228898426324], "unit": "score", "name": "Earley", "value": 930.7844895104892}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [41260.0], "unit": "score", "name": "RegExp", "value": 22.079132331555996}, {"lowerIsBetter": false, "replicates": [625.3908692933084], "unit": "score", "name": "Splay", "value": 130.30410899999995}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20247.820086877364}]} 19:25:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20247.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6908.28"}}} 19:25:37 INFO - Return code: 0 19:25:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:25:37 INFO - # TBPL SUCCESS # 19:25:37 INFO - Running post-action listener: _resource_record_post_action 19:25:37 INFO - Running post-run listener: _resource_record_post_run 19:25:38 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552603648; Read time: 140; Write time: 462008 19:25:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 179720192; Read time: 0; Write time: 215784 19:25:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314929152; Read time: 140; Write time: 221016 19:25:38 INFO - Running post-run listener: _upload_blobber_files 19:25:38 INFO - Blob upload gear active. 19:25:38 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:25:38 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 19:25:38 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:25:38 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:25:38 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:39 INFO - (blobuploader) - INFO - Done attempting. 19:25:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:40 INFO - (blobuploader) - INFO - Done attempting. 19:25:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:40 INFO - Return code: 0 19:25:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:25:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39954c669932dc07672c08d59fc61b6be9ca59c6ab4027d7b0474c5947e5c3b3801d2141b0199a0ab2dbfb427c1d113d35710579a1196fa2e55b2ea2458a6556", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/743fe143f2746f76115e39787f8bd7024835866f87efbffd21fd9c96c54c3a5b72159558c3eebff81c091c2639202db8399b0d1a583a3958e23b064c35fad3d6"} 19:25:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:25:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:25:40 INFO - Contents: 19:25:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39954c669932dc07672c08d59fc61b6be9ca59c6ab4027d7b0474c5947e5c3b3801d2141b0199a0ab2dbfb427c1d113d35710579a1196fa2e55b2ea2458a6556", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/743fe143f2746f76115e39787f8bd7024835866f87efbffd21fd9c96c54c3a5b72159558c3eebff81c091c2639202db8399b0d1a583a3958e23b064c35fad3d6"} 19:25:40 INFO - Copying logs to upload dir... 19:25:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.147127 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 19:25:40.206494) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:40.209984) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 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/Fx-Team/sha512/39954c669932dc07672c08d59fc61b6be9ca59c6ab4027d7b0474c5947e5c3b3801d2141b0199a0ab2dbfb427c1d113d35710579a1196fa2e55b2ea2458a6556", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/743fe143f2746f76115e39787f8bd7024835866f87efbffd21fd9c96c54c3a5b72159558c3eebff81c091c2639202db8399b0d1a583a3958e23b064c35fad3d6"} build_url:https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/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/Fx-Team/sha512/39954c669932dc07672c08d59fc61b6be9ca59c6ab4027d7b0474c5947e5c3b3801d2141b0199a0ab2dbfb427c1d113d35710579a1196fa2e55b2ea2458a6556", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/743fe143f2746f76115e39787f8bd7024835866f87efbffd21fd9c96c54c3a5b72159558c3eebff81c091c2639202db8399b0d1a583a3958e23b064c35fad3d6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:40.234759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:40.235073) ========= 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=db0483c52d987ecb441a263b000001ad-1452825828.396779-865246579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:40.319227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 19:25:40.319548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 19:25:40.319852) ========= ========= Total master_lag: 0.30 =========