builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1452827065.49 results: success (0) buildid: 20160114173018 builduid: 2543b59e8e23400a839328df44d9ec00 revision: 0d39fb92a77487fe494da2b3721815aa50cec625 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.488573) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.489031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.489313) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006172 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.512386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.512677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.542116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.542428) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.590879) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.591144) ========= 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:25.591539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.591850) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 19:04:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-14 19:04:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.775954) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.776228) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014269 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.825213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:25.825575) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 19:04:26,555 truncating revision to first 12 chars 2016-01-14 19:04:26,555 Setting DEBUG logging. 2016-01-14 19:04:26,555 attempt 1/10 2016-01-14 19:04:26,555 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:26,803 unpacking tar archive at: fx-team-0d39fb92a774/testing/mozharness/ program finished with exit code 0 elapsedTime=0.570884 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:26.409217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:26.409534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:26.425214) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 19:04:26.425478) ========= 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:26.425847) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-14 19:04:26.426124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:27 INFO - MultiFileLogger online at 20160114 19:04:27 in /builds/slave/test-pgo 19:04:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:04:27 INFO - {'append_to_log': False, 19:04:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:04:27 INFO - 'blob_upload_branch': 'Fx-Team', 19:04:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:04:27 INFO - 'branch': 'Fx-Team', 19:04:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:27 INFO - 'config_files': ('talos/linux_config.py',), 19:04:27 INFO - 'default_actions': ('clobber', 19:04:27 INFO - 'read-buildbot-config', 19:04:27 INFO - 'download-and-extract', 19:04:27 INFO - 'populate-webroot', 19:04:27 INFO - 'create-virtualenv', 19:04:27 INFO - 'install', 19:04:27 INFO - 'run-tests'), 19:04:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:27 INFO - 'download_minidump_stackwalk': True, 19:04:27 INFO - 'download_symbols': 'ondemand', 19:04:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:27 INFO - 'installer_path': 'installer.exe', 19:04:27 INFO - 'log_level': 'info', 19:04:27 INFO - 'log_name': 'talos', 19:04:27 INFO - 'log_to_console': True, 19:04:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:27 INFO - 'opt_config_files': (), 19:04:27 INFO - 'pip_index': False, 19:04:27 INFO - 'sps_profile': False, 19:04:27 INFO - 'sps_profile_interval': 0, 19:04:27 INFO - 'suite': 'dromaeojs', 19:04:27 INFO - 'system_bits': '32', 19:04:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:27 INFO - 'title': 'talos-linux64-ix-018', 19:04:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:27 INFO - 'use_talos_json': True, 19:04:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:04:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:27 INFO - 'work_dir': 'build'} 19:04:27 INFO - ##### 19:04:27 INFO - ##### Running clobber step. 19:04:27 INFO - ##### 19:04:27 INFO - Running pre-action listener: _resource_record_pre_action 19:04:27 INFO - Running main action method: clobber 19:04:27 INFO - rmtree: /builds/slave/test-pgo/build 19:04:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:04:27 INFO - Running post-action listener: _resource_record_post_action 19:04:27 INFO - ##### 19:04:27 INFO - ##### Running read-buildbot-config step. 19:04:27 INFO - ##### 19:04:27 INFO - Running pre-action listener: _resource_record_pre_action 19:04:27 INFO - Running main action method: read_buildbot_config 19:04:27 INFO - Using buildbot properties: 19:04:27 INFO - { 19:04:27 INFO - "project": "", 19:04:27 INFO - "product": "firefox", 19:04:27 INFO - "script_repo_revision": "production", 19:04:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:04:27 INFO - "repository": "", 19:04:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:04:27 INFO - "buildid": "20160114173018", 19:04:27 INFO - "pgo_build": "True", 19:04:27 INFO - "basedir": "/builds/slave/test-pgo", 19:04:27 INFO - "buildnumber": 581, 19:04:27 INFO - "slavename": "talos-linux64-ix-018", 19:04:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:04:27 INFO - "platform": "ubuntu64_hw", 19:04:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:04:27 INFO - "branch": "fx-team", 19:04:27 INFO - "repo_path": "integration/fx-team", 19:04:27 INFO - "revision": "0d39fb92a77487fe494da2b3721815aa50cec625", 19:04:27 INFO - "stage_platform": "linux64-pgo", 19:04:27 INFO - "builduid": "2543b59e8e23400a839328df44d9ec00", 19:04:27 INFO - "slavebuilddir": "test" 19:04:27 INFO - } 19:04:27 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:27 INFO - Running post-action listener: _resource_record_post_action 19:04:27 INFO - ##### 19:04:27 INFO - ##### Running download-and-extract step. 19:04:27 INFO - ##### 19:04:27 INFO - Running pre-action listener: _resource_record_pre_action 19:04:27 INFO - Running main action method: download_and_extract 19:04:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:27 INFO - https://queue.taskcluster.net/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json 19:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EahVMgSvQ7ayXovvigrjGw/artifacts/public/build/test_packages.json 19:04:27 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:27 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:30 INFO - Downloaded 1448 bytes. 19:04:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:04:30 INFO - Using the following test package requirements: 19:04:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:04:30 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:04:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'jsshell-linux-x86_64.zip'], 19:04:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:04:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:04:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:04:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:04:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:04:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:04:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:04:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:04:30 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:30 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:30 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:30 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:30 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:30 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:34 INFO - Downloaded 22439258 bytes. 19:04:34 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:34 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:35 INFO - Return code: 0 19:04:35 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:35 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:35 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:35 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:35 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:35 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:35 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:38 INFO - Downloaded 22439258 bytes. 19:04:38 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:38 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:39 INFO - Return code: 0 19:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:39 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:39 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:39 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:39 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:39 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:42 INFO - Downloaded 11132144 bytes. 19:04:42 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:42 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:42 INFO - Return code: 0 19:04:42 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:42 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:42 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:42 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:42 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:42 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:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:04:47 INFO - Installing pip.................done. 19:04:47 INFO - Return code: 0 19:04:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:47 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 19:04:47 INFO - 'HOME': '/home/cltbld', 19:04:47 INFO - 'LANG': 'en_US.UTF-8', 19:04:47 INFO - 'LANGUAGE': 'en_US:en', 19:04:47 INFO - 'LOGNAME': 'cltbld', 19:04:47 INFO - 'MAIL': '/var/mail/cltbld', 19:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:47 INFO - 'MOZ_NO_REMOTE': '1', 19:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:47 INFO - 'NO_EM_RESTART': '1', 19:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:47 INFO - 'SHELL': '/bin/bash', 19:04:47 INFO - 'SHLVL': '1', 19:04:47 INFO - 'TERM': 'linux', 19:04:47 INFO - 'TMOUT': '86400', 19:04:47 INFO - 'USER': 'cltbld', 19:04:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 19:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:47 INFO - '_': '/tools/buildbot/bin/python'} 19:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:47 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:47 INFO - Cleaning up... 19:04:47 INFO - Return code: 0 19:04:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:47 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 19:04:47 INFO - 'HOME': '/home/cltbld', 19:04:47 INFO - 'LANG': 'en_US.UTF-8', 19:04:47 INFO - 'LANGUAGE': 'en_US:en', 19:04:47 INFO - 'LOGNAME': 'cltbld', 19:04:47 INFO - 'MAIL': '/var/mail/cltbld', 19:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:47 INFO - 'MOZ_NO_REMOTE': '1', 19:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:47 INFO - 'NO_EM_RESTART': '1', 19:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:47 INFO - 'SHELL': '/bin/bash', 19:04:47 INFO - 'SHLVL': '1', 19:04:47 INFO - 'TERM': 'linux', 19:04:47 INFO - 'TMOUT': '86400', 19:04:47 INFO - 'USER': 'cltbld', 19:04:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 19:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:47 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:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:04:49 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:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:04:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:04:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:04:49 INFO - Installing collected packages: psutil 19:04:49 INFO - Running setup.py install for psutil 19:04:49 INFO - building 'psutil._psutil_linux' extension 19:04:49 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 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:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 19:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:52 INFO - '_': '/tools/buildbot/bin/python'} 19:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 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:54 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:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:04:54 INFO - Downloading/unpacking docopt==0.6.1 (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 - 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:55 INFO - Successfully installed blobuploader requests docopt 19:04:55 INFO - Cleaning up... 19:04:55 INFO - Return code: 0 19:04:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:04:55 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:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 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:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:55 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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:55 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:55 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:55 INFO - Using env: {'DISPLAY': ':0', 19:04:55 INFO - 'HOME': '/home/cltbld', 19:04:55 INFO - 'LANG': 'en_US.UTF-8', 19:04:55 INFO - 'LANGUAGE': 'en_US:en', 19:04:55 INFO - 'LOGNAME': 'cltbld', 19:04:55 INFO - 'MAIL': '/var/mail/cltbld', 19:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:55 INFO - 'MOZ_NO_REMOTE': '1', 19:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:55 INFO - 'NO_EM_RESTART': '1', 19:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:04:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:04:55 INFO - 'SHELL': '/bin/bash', 19:04:55 INFO - 'SHLVL': '1', 19:04:55 INFO - 'TERM': 'linux', 19:04:55 INFO - 'TMOUT': '86400', 19:04:55 INFO - 'USER': 'cltbld', 19:04:55 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 19:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:55 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-enWiiP-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-8sSWf6-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-xjpsZL-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-9PtOsQ-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-CCdtJy-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-3zlSzs-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-6JPg9x-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-X6rzps-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-_mxtma-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-50aSqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:04:56 INFO - Running setup.py (path:/tmp/pip-IS3ACY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:04:56 INFO - Running setup.py (path:/tmp/pip-NdXmwz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:04:56 INFO - Running setup.py (path:/tmp/pip-HNBKGv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:04:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:04:56 INFO - Running setup.py (path:/tmp/pip-StdroO-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-y2txMG-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-wjxiGO-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-tis5sw-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:57 INFO - Running setup.py install for mozhttpd 19:04:57 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:04:57 INFO - Running setup.py install for mozinfo 19:04:57 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:04:57 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:58 INFO - Running setup.py install for mozscreenshot 19:04:58 INFO - Running setup.py install for moztest 19:04:58 INFO - Running setup.py install for mozversion 19:04:58 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:04:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:58 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 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-rJydgP-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-radNPv-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-Q_qCWI-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-9ftmq6-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-i2JatT-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-QlNrJd-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-Zg64HK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:04:59 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:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:04:59 INFO - Running setup.py (path:/tmp/pip-Mkk8yA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:04:59 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:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:04:59 INFO - Running setup.py (path:/tmp/pip-HPZrJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:04:59 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:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:04:59 INFO - Running setup.py (path:/tmp/pip-amgh8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:04:59 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:04:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:04:59 INFO - Running setup.py (path:/tmp/pip-nVo4ti-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-5ZKihn-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-dMnb8e-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-cOCTVN-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-y6XVxi-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-O5T8kr-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-Ry2HTa-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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 19:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:02 INFO - '_': '/tools/buildbot/bin/python'} 19:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Cleaning up... 19:05:02 INFO - Return code: 0 19:05:02 INFO - Installing jsonschema 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', '--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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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', '--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:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 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 - 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:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:04 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:04 INFO - Downloading/unpacking functools32 (from jsonschema) 19:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:04 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:04 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:04 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 0x7f163911af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2759630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', '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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 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:07 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:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:07 INFO - no previously-included directories found matching 'docs/_build' 19:05:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:05:07 INFO - Running setup.py install for pep8 19:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:05:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:05:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:05:07 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 0x27ea840>, '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 0x27576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2757b60>, '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', '--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-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 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 --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-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 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': '62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577', 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', '--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-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 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:36692' 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 4363 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJqKtf6/profile http://localhost:36692/getInfo.html) 19:05:29 INFO - PROCESS | 4363 | __metrics Screen width/height:1600/1200 19:05:29 INFO - PROCESS | 4363 | colorDepth:24 19:05:29 INFO - PROCESS | 4363 | Browser inner width/height: 1024/697 19:05:29 INFO - PROCESS | 4363 | __metrics 19:05:29 INFO - PROCESS | 4363 | 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:29 INFO - PROCESS | 4363 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:05:30 INFO - TEST-INFO | 4363: exit 0 19:05:30 INFO - Browser initialized. 19:05:30 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:30 INFO - TEST-INFO | started process 4460 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJqKtf6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:05:42 INFO - PROCESS | 4460 | RSS: Main: 149217280 19:05:42 INFO - PROCESS | 4460 | 19:06:33 INFO - PROCESS | 4460 | 1452827193625 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 | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36692/tests/dromaeo/cssquery-ext.html) 19:08:42 INFO - PROCESS | 4460 | RSS: Main: 252149760 19:08:42 INFO - PROCESS | 4460 | 19:11:45 INFO - PROCESS | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-ext.html (next: http://localhost:36692/tests/dromaeo/cssquery-jquery.html) 19:11:45 INFO - PROCESS | 4460 | RSS: Main: 231002112 19:11:45 INFO - PROCESS | 4460 | 19:14:47 INFO - PROCESS | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36692/tests/dromaeo/cssquery-mootools.html) 19:14:48 INFO - PROCESS | 4460 | RSS: Main: 228671488 19:14:48 INFO - PROCESS | 4460 | 19:17:50 INFO - PROCESS | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36692/tests/dromaeo/cssquery-prototype.html) 19:17:50 INFO - PROCESS | 4460 | RSS: Main: 210300928 19:17:50 INFO - PROCESS | 4460 | 19:20:53 INFO - PROCESS | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36692/tests/dromaeo/cssquery-yui.html) 19:20:53 INFO - PROCESS | 4460 | RSS: Main: 215269376 19:20:53 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | Cycle 1(1): loaded http://localhost:36692/tests/dromaeo/cssquery-yui.html (next: http://localhost:36692/tests/dromaeo/cssquery-dojo.html) 19:23:56 INFO - PROCESS | 4460 | RSS: Main: 270823424 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | __start_tp_report 19:23:56 INFO - PROCESS | 4460 | _x_x_mozilla_page_load 19:23:56 INFO - PROCESS | 4460 | _x_x_mozilla_page_load_details 19:23:56 INFO - PROCESS | 4460 | |i|pagename|runs| 19:23:56 INFO - PROCESS | 4460 | |0;dojo.html;3114.563961045454;3139.7331226845718;3181.125190572592;3185.028566287283;3204.791688540244;4970.652054356187;5038.370203724535;5089.770960306786;5098.515641014107;5147.819826306075;4929.457759646436;4963.950360496394;5053.242013697938;5112.769925353358;5133.9229911551265;4579.771011449422;4594.287885377772;4605.332226827108;4656.7205967641885;4669.649776266777;549.7986974670066;4581.816727330903;4587.977060114695;4602.516735742749;4697.107549565589;4587.678862479628;4602.815887364518;4629.722216667011;4631.930521042187;4650.372199753041;4683.110209060268;4683.7892294846815;4684.742339171345;4711.552402521755;4728.054389122155;4564.064366804797;4628.83799067031;4647.442306923157;4680;4686.53134686532;4903.166461701519;4917.532834380728;4930.531599498042;4949.950500494985;4965.776540055706;5394.595405344615;5405.405405405402;5405.567554595662;5427.0773968425465;5447.618666693294;5277.894442111136;5350.705711185883;5453.072977593779;5464.644798088151;5524.668519888779;5105.438401775802;5114.590832733373;5116.488351164854;5121.129408000612;5166.328377310925;5529.529989950819;5538.529225015838;5541.196526503634;5541.307336582927;5558.833235002957;5252.579793616502;5328.49379308965;5361.437049109865;5368.946310536923;5436.728163591804;5460.180972854104;5469.890602187934;5474.069408200616;5477.698726570077;5479.808206712746;5317.521423071942;5443.183522471661;5444.8094316698725;5453.318335208099;5487;5224.738763061831;5442.972785136049;5457.945420545823;5478.863028424321;5515.310586176728;4267.0825772459075;4283.400323954649;4285.46431696038;4292.270314046619;4325.134973005412;3766.265578212277;3841.2893614681375;3850.6726928210855;3866.9613303867163;3874.6706529945272;5095.286659867622;5112.258722485219;5132.56373208274;5133.948660513422;5174.43081261061;5464.9453505465235;5507.752151153208;5534.391216966131;5534.418886016991;5576.888462230732;5011.523905228997;5062.898742025139;5103.540681338697;5122.257272695439;5138.023775482647;4718.740469274223;4733.148033354029;4737.668363214542;4759.833405830779;4780.521947805191;5724.685142317129;5727.5131613812455;5728.914066289009;5729.369769325371;5729.570282228766;5420.7560659769615;5485.9725701371235;5497.917531237114;5514.117741161555;5587.69267690281;5614.382417934105;5624.268845050117;5648.915266270927;5654.321481422256;5665.376808551138;5370.731463426891;5376.462353764592;5377.637773262614;5378.489043541014;5403.324584426947;5377.542908852792;5389.434109418455;5412.458754124714;5448.782048718007;5471.452854714496;5357.491038351351;5377.112776391851;5383.08487557124;5393.892122157614;5394.892102157856;5155.561777248976;5356.491133342326;5376.193570964387;5377.27406800077;5392.757325920422;5142.922856157086;5297.073012222922;5338.652987555796;5368.973155134199;5393.029254734185;5359.330083739533;5364.8122315718765;5374.973125134349;5379.381371142369;5380.192971054216;5242.737863106906;5270.789168433374;5272.209168624737;5312.920306195488;5313.362396512443 19:23:56 INFO - PROCESS | 4460 | |1;ext.html;525.7739172155973;543.2123421039494;565.4430386069718;575.9948889188366;585.7861880413649;27866.30334241645;28548.57177142342;28565.57151642727;34689.65310346902;35369.82315088427;38640.80679596598;39114;39146.28110329514;39168.41247381292;39198.21603567927;8532.317414606847;8871.512066836322;8881.378303518757;8885.42244754089;8887.377883548153;8537.573121343908;8698.347623928199;8707.95646021769;8709.433886797338;8712.651493940235;8680.305575553972;8764.693235736751;8767.254783343424;8769.254613357873;8774.298056155525;8617;8700.912990870074;8707.390482666216;8722.08418116095;8724.432911860773;8531.360147988926;8632.266257368132;8680.435771674884;8688.913110868874;8690.261327787082;38120.80939595284;38536.42195367072;38756.61243387587;38890.416643750366;38952.61047389518;3102.829344386058;3166.0501849445304;3227.273863380744;3460.2560449503476;3926.666233370167;28668.569971450444;28881.277968050756;29711.70288297111;29982.400351993056;30130.54804177939;3641.198936234024;3663.19409729859;3673.246984368198;3743.3074881146804;3872.3997780344093;275867;276531;277869;278063;278311;56660.71669641625;56902.715486422305;56987.430125699044;56999.43000570024;57120.14319785206;59472.70263648654;59692;59729.701351492964;59762;59781.402185978455;14864.62838429048;15158.090514569161;15195.088294702353;15201.6199595011;15207.695846083237;11755.706107347385;11810.232334898204;11830;11830.231034982698;11833.881661183277;17955.281788728305;18392.540186495444;18465.507156533964;18485.260589576268;18488.35290764817;7184.928150718426;7261.128664560287;7355.227701091415;7374.225706300761;7411.444141689287;858.8969323681198;890.8619164029586;912.7489940266347;979.2557656181353;1016.4358780876685;24433.755662443502;24857.25428237156;24912.750872491044;27969.580456293173;28670.42659146847;879.9322976724911;932.8320902237526;982.1308142293979;983.1790454970037;995.6764051683087;12149.210301330386;13054.21674699502;13275.535356262677;13313.800292995613;13327.600171994856;323032;323372;325584;327682;328048;41015.923805714694;41763.7911810439;46520;47519.5248047522;49020;1303.2050449225965;1311.8294621699308;1316.0327159537733;1316.1839659411226;1334.2794890758883;23597.528049439257;25376.365590860376;26692.065777697688;26841.731582684704;26970.460590788465;40112.39831402589;46951.29573056338;47438.76280618575;47731;47741.283880741124;198864;200350;200733;200845;200865;28408.147755567366;28523.42953140967;28552.143435696962;28971.420571588027;29040.273993150342;40378.39432408575;43221.3516797242;43287.56712432835;44271.77864110659;44439.33340999823;36398.8180059098;36695.63304366922;37328.25343493061;37560;37993;35609.28781424409;36113;36243.63756362403;36539.63460365469;36994.8150259247;35788.82105589456;35933.28133437369;36030.4595431074;36100.81949590235;36778.63221367752;30706.232344191572;30948;31062.602182901373;31492.842535787175;31782;23715.40711482227;24075.73084362498;24197;24351.878240608683;24384 19:23:56 INFO - PROCESS | 4460 | |2;jquery.html;362.213995629484;362.4147002590816;363.7762775892826;366.94312381580863;369.20068052665977;12854.614361569145;12887.851958203704;15512.84487155128;16586.25361858716;17605.559861003465;13572.660683482893;14054.859451405482;14483.131012139253;14498.13011219325;14947.850521494782;5145.382554093505;5349.5720342372515;5354.170103633943;5356.464353564632;5363.865903352428;3926.6858651307825;4041.2725709372303;5311.362636483608;5402.729863506828;5477.7261136943;5708.943845388596;5809.651420914737;5860.648361098348;5862.530997520188;5866.73599688015;5689.943100568983;5811.912821307642;5820.272465941757;5825.650460972334;5838.795642152526;5002.424721157077;5153.149730294497;5154.149565321717;5221.112410890158;5228.137357336035;18884;19396.903015484975;19732.21071157152;20081.698774518394;20424.79575204244;2032.1160295271457;2200.460887082659;2261.513774538466;2394.4253379188867;2867.956980645292;12649.557265495756;12768.872311276862;12865.16376435538;12890.355482225852;13100.934495327558;1890.3383815664545;1914.838760858351;1941.0682872221412;1996.6605677034938;2002.909869055896;61276.69361653208;62221.37778622201;63861.680691596244;63955;64285.03572446417;14774.926125369304;14775.556733298019;14812.11127332342;14838.703225935637;14850.777238341434;22577.09691612317;22618.66072008921;23087.653685194735;23165.652515211947;23172.65241021386;8768.561571921506;8772.649094036167;8857.867131993025;8868.689595864114;8924.152205540464;7432.070991126109;7478.3643390311345;7482.176960534337;7509.887351689729;7510.662020208994;7375.44684148691;7462.813429664302;7478.401727861758;7494.100707914976;7603.315701586884;1784.9018303993146;1814.7640806695044;1819.1904602452046;1835.8072402397822;2139.935801925945;869.5130726793017;885.3094586222628;896.9058248883904;997.4065431068502;1012.5645972231864;14096.85903140976;15311.387544498319;15492.14793186363;15728.292226849819;16853.59712588196;898.9190972812478;901.6348378906554;960.0687333286701;977.1986970683971;1019.6278358399131;8733.475991440533;9064.818703625891;9066.95466522663;9197.356185066981;9271.582778774971;345222;481755;563136;569457.3054269404;571383;65212;66148.6692566534;68072;69914.65042674754;74478.25521744713;1017.9032991865909;1039.5270152080784;1054.0355574649263;1054.414799786126;1062.9627963021258;13517.256550889795;13826.446942122202;14060.789088163481;14111.647208819862;14913.105213687213;26971;28766.856165719037;32552.186195345304;32580;34058.82970585131;43811.780941095094;44607;45345.77327113343;45360.54639453563;45505.31742023806;6642.701078451385;6873.656317184221;6879.484038697017;6890.138732658418;7058.25888281723;9341.859872101788;10273.486325683836;10553.683389498021;10590.417527036087;10726.839097413702;9264.490453024879;9284.860727089233;9353.20497757671;9527;9553.092456216647;8916.910830891868;9252.545146193585;9321.254299655875;9333.53332333367;9614.95192524033;9262.536873156181;9311.255099591881;9401.576929038347;9646.90353096488;9742;6931.202911665021;7004.124484439445;7205;7236.565806051653;7261.092363454568;8453.154684531497;8601.354898382771;8775.561221939006;8790.989036260657;8827.779305517157 19:23:56 INFO - PROCESS | 4460 | |3;mootools.html;1258.8929940955018;1382.2052319916047;1385.5566218809981;1504.8720858727008;1733.5178422448805;6866.588004719721;7450.813729656755;7576.77269681909;7590.127135379433;7590.658420371083;7732.304092631662;7916.960415197916;7924.207579242073;7924.6433910474025;7928.722494712686;1971.2115153938469;1993.1329871505868;2283.3834864586634;2300.7584203658585;2341.6487526870937;2318.038014224095;2322.976770232293;2327.034280773477;2327.5810354136247;2338.9766102339013;2236.7875051870046;2316.652502124686;2316.7104111986;2317.432229103872;2318.385627808632;2263.592553340398;2295.104909085458;2302.930912072624;2305.4236440889777;2305.9769402306015;2272.8863556822257;2280.9543809123725;2297.414159389362;2301.827362947786;2303.0672577606097;8008.919910800876;8081.272685458278;8083.393745469113;8083.555404452753;8086.838263234761;4756.571908528214;4914.91871788206;4916.606671466274;4920.089783390084;4943.505649435064;3091.335362896988;3144.874205031796;3204.7275981541598;3225.080851957181;3231.644519102897;1015.3856916565445;1020.1277907389224;1046.1473898772476;1050.7583255851198;1073.1093192650083;11142.164337674625;11315.038221751161;11322.490487928064;11336.603218887381;11355.432228388547;4426.9778651106535;4511.278195488706;4517.232070548015;4536.591706746409;4547.295169248771;8877.73366798997;8915.37592368528;8954.955225223963;8956.193942545202;8956.776080598038;4914.852554423373;4939;4942.406911170682;4945.332380128709;4952.232403977389;4481.910361792746;4522.140793249338;4537.705049171794;4567.13224487353;4568.588827005586;3332.600087989408;3381.8309084545676;3416.3338149060696;3610.0433385152955;3696.8890933271505;1077.1436707817304;1079.3146352066337;1092.6121226964312;1105.867295924494;1106.076426184129;1248.7939489984233;1270.4498723590289;1281.8718128187106;1320.0957344219048;1320.8348956380453;7430.071241094864;7455.2172021938;7476.5514069156025;7476.962615186998;7484.476086673881;1152.827075938616;1160.6808127764764;1186.1815347410259;1198.0774803401332;1208.2146604707011;5733.71331433435;5770.394108618619;5836.949349117115;5852.268466441695;5861.589688721834;9089.318301127441;9328.347015708836;9419.670311539201;9561;9577;9370.34407591462;9403.670871519464;9417.576209070608;9440.055994400505;9444.150026497511;7224.096987876515;7400.814979625552;7486.43851711113;7486.775396737998;7488.326050655467;7035.859282814417;7077.327653872874;7088.291170882871;7148.820444626578;7152;8332.791680208044;8376.706815261437;8450.408471406943;8548.974123105267;8555.529445880537;8484.236418722345;8759.16787905148;8765.474071555727;8771.956140219514;8775.341849361195;6932.896006559805;7059.682314295766;7074.929250707427;7169.964150179216;7189.7483588074165;6663.700133493908;6804.863902722017;7301.196868344584;7541.811454713676;7551.244875512405;6891.689873955785;7069.434445244471;7110.040144580622;7137.321954414322;7318.817029574303;6924.619145947021;6973.79078627642;7010.894836577558;7070.964645176741;7118.715251389886;6931.4108300795;6965.477589180933;6980.232174460703;6982.546134501241;6985.196702379291;6234.625922444668;6273.1844860167885;6280.340564240872;6288.151099601679;6312.5265605078885;6631.3700198481065;6677.565958212701;6684.4318232950745;6815.93184068153;6830.829229269308 19:23:56 INFO - PROCESS | 4460 | |4;prototype.html;342.1258684062221;349.4164744876057;350.9263054758501;351.19400974762925;351.195761705694;5716.685582292972;5823.592348535604;5882.647041177533;5910.586258961875;5914.172015917769;5656.91514627281;5829.921464529065;5835.35811060784;5848.736806843692;5858.589898707092;4574;4577.793999270041;4580.770961451914;4592.517785632511;4600.585947264745;4385.8464953726625;4467.15124126415;4496.213162696531;4500.189965806154;4589.885252868671;4412.183746006983;4506.909861802762;4561.703489273186;4565.132624801277;4575.22221222393;4532.501424843264;4533.9319910201375;4540.18276710192;4548.499665036843;4570.474395444533;4021.8391264349393;4029.0531725044593;4032.737872038308;4037.4347591337237;4047.9190416191805;5440.836774896759;5576.804811831607;5578.581606379537;5608.327000759935;5613.522850557708;5156.20078887773;5167.896642067138;5171.896562068775;5176.6893986360565;5177.37871455424;5894.793682221101;6223.719932602999;6225.8132256032395;6247.031710084899;6270.561060725751;4246.978765106154;4255.829766809324;4359.8446411700925;4365.3451982202605;4377.23398405281;6397.52018598607;6473.611583305017;6484.481241500669;6487.481001519915;6506.186726659168;4466.4640243171025;4474.038081812361;4477.574630410106;4484.304932735431;4484.349769283501;4447.688661793708;4513;4518.548145185521;4537.3647689323525;4562.292844609091;5225.529702326809;5236.371635403776;5236.450172731885;5243.8164664236565;5245.973770131125;6271.686415679198;6285.245770507477;6285.654289014148;6286.088517164985;6291.402316779899;1584.7939767830107;1605.069059945229;1605.2615796733633;1606.5903194685513;1606.9276882540314;1055.9260851740305;1061.527620209015;1079.9892001080045;1081.6376513867785;1091.7106966653844;5931.139984702194;5931.406859314034;5937.050071988548;5939.46544810969;5951.9107213391835;6459;6463.353664633499;6471.9676401618635;6475.935240647627;6477.384648458389;5947;5948.256467941507;5950.2264705587995;5951.761929522857;5953.285605727254;3408.301298233856;3519.278547897726;3524.6827785499427;3524.7356448266482;3525.7179425645886;6811.829704257433;6816.113905192294;6817.761378351833;6821.21556021054;6823.727050918007;6676.666166691646;6680.532362734659;6684.2647308795995;6688.398044176048;6693.899591506131;6611.801645950629;6796.35434633709;6796.728130874809;6800.6939687714175;6801.387875091265;6220;6356.300806911144;6458.677066146768;6519.934800651933;6537.673116344259;6246.781362652286;6383.904241436475;6396.904046439214;6424.196975378078;6432.421082102634;6648.16897887764;6763.898541521783;6774.661266936535;6780;6847.62338071391;4483.193025255486;4569.862904112882;4617.584417402316;4629.351890735233;4640.443146822403;6453.838654033687;6455.644939528371;6456.54804163704;6457.773977910751;6467.450266727381;6286.465650419766;6293.118963345044;6293.559450838397;6293.842653933688;6294.213223347082;6158.538109641705;6198.101275315144;6272.310045895039;6280.874382512416;6286.308506064421;6148.385161483995;6158.815235542941;6165.784197553064;6168.321484636776;6172.6913654318005;6253;6293.527985401021;6303.779367722108;6307.148534947723;6309.179806625109;6067.908981365194;6119.755209791559;6155.045967874987;6155.938440615537;6163.753449861955 19:23:56 INFO - PROCESS | 4460 | |5;yui.html;818.4843548564407;819.983600327993;823.851706692795;828.2669837194084;860.238688760447;12650.304233267167;12688.682782930407;12770.93614531926;12817.42321595527;12830.166039207445;11709.59016434425;11745.823812642817;11774.764504709901;11776.646700598996;11787;785.9017622797136;792.2038351456778;792.3621484704811;793.028540038454;798.1938242375185;639.7984634840011;651.7881688451249;653.5294587896731;653.584973541802;797.1709422200933;673.2896793882452;818.9877151842727;833.1793183714037;839.2656425627575;840.306746933782;823.3372135430976;833.1668331668332;834.2491757418311;834.2991886815043;835.1523203947997;494.1944630252665;503.8639567316841;599.7990673124508;614.923134608174;617.2623714660982;12334.81497777534;12472.126951113425;12472.563460278938;12541.874581254162;12546.247225166519;11580.073594112451;11886.28682279066;11961.700957476045;12316.81524777129;12320.137590368679;10321.535530901052;10516.211284153642;10565.89058148891;10583.31208471447;10918.50866711;3588.730845186595;3620.6379362063844;3667.9083022924374;3668.248009158116;3722.1066943933533;43333.13333733339;43384;43398.349024764655;43703.56296437027;43934.56065439337;9195;9405.11216900023;9510.619575217052;9531.571079301448;9679.177269932135;15278.847211527742;15335.846641533664;17596.472105836845;17683.292668293383;17825.286988520573;7301.89047164293;7394;7488.4009279257525;7502.987096741979;7608.581528016012;4017.8191981360324;4052.8986775330263;4084.2852500812237;4100.138970816102;4169.041120542292;3143.2613335866054;3161.1148878314107;3165.920851978673;3180.904572862818;3184.2357834119643;548.5858177076282;561.4806304168628;565.9575531835129;573.9983728393979;575.7955925646335;493.33646245799343;617.9442656065712;630.3224034163293;641.4291280760127;646.9256035555877;8975.371723979259;9129.81740365189;9232;9276.536173191313;9430.3870248435;504.0372887784388;508.27063164358526;533.9893202135936;537.1539824775994;544.5670691800028;3767.7362584619364;3802.1445174835994;3918.7452815567467;3970.8014599269923;4182.100848317566;54469;57820;57859;57942;59765;49963;51313.48686513162;51554.48445515572;51619.22571161436;51872;43941.78029109898;44523.328600283436;44899.55100449019;45048;45367.773161133984;8402.411831172003;8420.494770313555;8843.46939183651;8914.28685705155;8916.25786459311;33587.83206083954;33798.83100584481;34352;34657.826710866284;34757.65242347544;41994.58005419907;45073.77463112663;45513;45532.544674554156;45578;10193;10780.838287425539;10792.622258220925;10805.729856753644;10806.255360740393;11385.17848084874;11448.313101213955;11665;11711.355875426592;11952.342621155572;10662.520186591466;10677.519511622151;10791.6222932197;10830.241883068109;12117.636470905887;10915.727106822393;10928.125749939827;11082.61210857616;11478.713032174262;11656.88568143056;10584.100351470212;11031.889681103086;11242.943785281348;11305.547778088785;11331.263467874562;9109.954450227706;9338.859917101114;9344.299177561574;9350.812983740423;9431.104045115702;9123;9296.256299496159;9613.182879455046;9835.901640983499;9842.75393115178 19:23:56 INFO - PROCESS | 4460 | __end_tp_report 19:23:56 INFO - PROCESS | 4460 | __start_cc_report 19:23:56 INFO - PROCESS | 4460 | _x_x_mozilla_cycle_collect,784 19:23:56 INFO - PROCESS | 4460 | __end_cc_report 19:23:56 INFO - PROCESS | 4460 | __startTimestamp1452828236947__endTimestamp 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | ------- Summary: start ------- 19:23:56 INFO - PROCESS | 4460 | Number of tests: 6 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#0] dojo.html Cycles:165 Average:5052.37 Median:5297.07 stddev:643.97 (12.2%) stddev-sans-first:627.74 19:23:56 INFO - PROCESS | 4460 | Values: 3114.6 3139.7 3181.1 3185.0 3204.8 4970.7 5038.4 5089.8 5098.5 5147.8 4929.5 4964.0 5053.2 5112.8 5133.9 4579.8 4594.3 4605.3 4656.7 4669.6 549.8 4581.8 4588.0 4602.5 4697.1 4587.7 4602.8 4629.7 4631.9 4650.4 4683.1 4683.8 4684.7 4711.6 4728.1 4564.1 4628.8 4647.4 4680.0 4686.5 4903.2 4917.5 4930.5 4950.0 4965.8 5394.6 5405.4 5405.6 5427.1 5447.6 5277.9 5350.7 5453.1 5464.6 5524.7 5105.4 5114.6 5116.5 5121.1 5166.3 5529.5 5538.5 5541.2 5541.3 5558.8 5252.6 5328.5 5361.4 5368.9 5436.7 5460.2 5469.9 5474.1 5477.7 5479.8 5317.5 5443.2 5444.8 5453.3 5487.0 5224.7 5443.0 5457.9 5478.9 5515.3 4267.1 4283.4 4285.5 4292.3 4325.1 3766.3 3841.3 3850.7 3867.0 3874.7 5095.3 5112.3 5132.6 5133.9 5174.4 5464.9 5507.8 5534.4 5534.4 5576.9 5011.5 5062.9 5103.5 5122.3 5138.0 4718.7 4733.1 4737.7 4759.8 4780.5 5724.7 5727.5 5728.9 5729.4 5729.6 5420.8 5486.0 5497.9 5514.1 5587.7 5614.4 5624.3 5648.9 5654.3 5665.4 5370.7 5376.5 5377.6 5378.5 5403.3 5377.5 5389.4 5412.5 5448.8 5471.5 5357.5 5377.1 5383.1 5393.9 5394.9 5155.6 5356.5 5376.2 5377.3 5392.8 5142.9 5297.1 5338.7 5369.0 5393.0 5359.3 5364.8 5375.0 5379.4 5380.2 5242.7 5270.8 5272.2 5312.9 5313.4 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#1] ext.html Cycles:180 Average:43280.33 Median:20179.41 stddev:71375.03 (353.7%) stddev-sans-first:71503.07 19:23:56 INFO - PROCESS | 4460 | Values: 525.8 543.2 565.4 576.0 585.8 27866.3 28548.6 28565.6 34689.7 35369.8 38640.8 39114.0 39146.3 39168.4 39198.2 8532.3 8871.5 8881.4 8885.4 8887.4 8537.6 8698.3 8708.0 8709.4 8712.7 8680.3 8764.7 8767.3 8769.3 8774.3 8617.0 8700.9 8707.4 8722.1 8724.4 8531.4 8632.3 8680.4 8688.9 8690.3 38120.8 38536.4 38756.6 38890.4 38952.6 3102.8 3166.1 3227.3 3460.3 3926.7 28668.6 28881.3 29711.7 29982.4 30130.5 3641.2 3663.2 3673.2 3743.3 3872.4 275867.0 276531.0 277869.0 278063.0 278311.0 56660.7 56902.7 56987.4 56999.4 57120.1 59472.7 59692.0 59729.7 59762.0 59781.4 14864.6 15158.1 15195.1 15201.6 15207.7 11755.7 11810.2 11830.0 11830.2 11833.9 17955.3 18392.5 18465.5 18485.3 18488.4 7184.9 7261.1 7355.2 7374.2 7411.4 858.9 890.9 912.7 979.3 1016.4 24433.8 24857.3 24912.8 27969.6 28670.4 879.9 932.8 982.1 983.2 995.7 12149.2 13054.2 13275.5 13313.8 13327.6 323032.0 323372.0 325584.0 327682.0 328048.0 41015.9 41763.8 46520.0 47519.5 49020.0 1303.2 1311.8 1316.0 1316.2 1334.3 23597.5 25376.4 26692.1 26841.7 26970.5 40112.4 46951.3 47438.8 47731.0 47741.3 198864.0 200350.0 200733.0 200845.0 200865.0 28408.1 28523.4 28552.1 28971.4 29040.3 40378.4 43221.4 43287.6 44271.8 44439.3 36398.8 36695.6 37328.3 37560.0 37993.0 35609.3 36113.0 36243.6 36539.6 36994.8 35788.8 35933.3 36030.5 36100.8 36778.6 30706.2 30948.0 31062.6 31492.8 31782.0 23715.4 24075.7 24197.0 24351.9 24384.0 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#2] jquery.html Cycles:180 Average:27046.28 Median:5269.75 stddev:83959.28 (1593.2%) stddev-sans-first:84170.89 19:23:56 INFO - PROCESS | 4460 | Values: 362.2 362.4 363.8 366.9 369.2 12854.6 12887.9 15512.8 16586.3 17605.6 13572.7 14054.9 14483.1 14498.1 14947.9 5145.4 5349.6 5354.2 5356.5 5363.9 3926.7 4041.3 5311.4 5402.7 5477.7 5708.9 5809.7 5860.6 5862.5 5866.7 5689.9 5811.9 5820.3 5825.7 5838.8 5002.4 5153.1 5154.1 5221.1 5228.1 18884.0 19396.9 19732.2 20081.7 20424.8 2032.1 2200.5 2261.5 2394.4 2868.0 12649.6 12768.9 12865.2 12890.4 13100.9 1890.3 1914.8 1941.1 1996.7 2002.9 61276.7 62221.4 63861.7 63955.0 64285.0 14774.9 14775.6 14812.1 14838.7 14850.8 22577.1 22618.7 23087.7 23165.7 23172.7 8768.6 8772.6 8857.9 8868.7 8924.2 7432.1 7478.4 7482.2 7509.9 7510.7 7375.4 7462.8 7478.4 7494.1 7603.3 1784.9 1814.8 1819.2 1835.8 2139.9 869.5 885.3 896.9 997.4 1012.6 14096.9 15311.4 15492.1 15728.3 16853.6 898.9 901.6 960.1 977.2 1019.6 8733.5 9064.8 9067.0 9197.4 9271.6 345222.0 481755.0 563136.0 569457.3 571383.0 65212.0 66148.7 68072.0 69914.7 74478.3 1017.9 1039.5 1054.0 1054.4 1063.0 13517.3 13826.4 14060.8 14111.6 14913.1 26971.0 28766.9 32552.2 32580.0 34058.8 43811.8 44607.0 45345.8 45360.5 45505.3 6642.7 6873.7 6879.5 6890.1 7058.3 9341.9 10273.5 10553.7 10590.4 10726.8 9264.5 9284.9 9353.2 9527.0 9553.1 8916.9 9252.5 9321.3 9333.5 9615.0 9262.5 9311.3 9401.6 9646.9 9742.0 6931.2 7004.1 7205.0 7236.6 7261.1 8453.2 8601.4 8775.6 8791.0 8827.8 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#3] mootools.html Cycles:180 Average:5519.69 Median:6253.91 stddev:2855.63 (45.7%) stddev-sans-first:2845.68 19:23:56 INFO - PROCESS | 4460 | Values: 1258.9 1382.2 1385.6 1504.9 1733.5 6866.6 7450.8 7576.8 7590.1 7590.7 7732.3 7917.0 7924.2 7924.6 7928.7 1971.2 1993.1 2283.4 2300.8 2341.6 2318.0 2323.0 2327.0 2327.6 2339.0 2236.8 2316.7 2316.7 2317.4 2318.4 2263.6 2295.1 2302.9 2305.4 2306.0 2272.9 2281.0 2297.4 2301.8 2303.1 8008.9 8081.3 8083.4 8083.6 8086.8 4756.6 4914.9 4916.6 4920.1 4943.5 3091.3 3144.9 3204.7 3225.1 3231.6 1015.4 1020.1 1046.1 1050.8 1073.1 11142.2 11315.0 11322.5 11336.6 11355.4 4427.0 4511.3 4517.2 4536.6 4547.3 8877.7 8915.4 8955.0 8956.2 8956.8 4914.9 4939.0 4942.4 4945.3 4952.2 4481.9 4522.1 4537.7 4567.1 4568.6 3332.6 3381.8 3416.3 3610.0 3696.9 1077.1 1079.3 1092.6 1105.9 1106.1 1248.8 1270.4 1281.9 1320.1 1320.8 7430.1 7455.2 7476.6 7477.0 7484.5 1152.8 1160.7 1186.2 1198.1 1208.2 5733.7 5770.4 5836.9 5852.3 5861.6 9089.3 9328.3 9419.7 9561.0 9577.0 9370.3 9403.7 9417.6 9440.1 9444.2 7224.1 7400.8 7486.4 7486.8 7488.3 7035.9 7077.3 7088.3 7148.8 7152.0 8332.8 8376.7 8450.4 8549.0 8555.5 8484.2 8759.2 8765.5 8772.0 8775.3 6932.9 7059.7 7074.9 7170.0 7189.7 6663.7 6804.9 7301.2 7541.8 7551.2 6891.7 7069.4 7110.0 7137.3 7318.8 6924.6 6973.8 7010.9 7071.0 7118.7 6931.4 6965.5 6980.2 6982.5 6985.2 6234.6 6273.2 6280.3 6288.2 6312.5 6631.4 6677.6 6684.4 6815.9 6830.8 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#4] prototype.html Cycles:180 Average:5247.65 Median:5922.66 stddev:1571.94 (26.5%) stddev-sans-first:1532.63 19:23:56 INFO - PROCESS | 4460 | Values: 342.1 349.4 350.9 351.2 351.2 5716.7 5823.6 5882.6 5910.6 5914.2 5656.9 5829.9 5835.4 5848.7 5858.6 4574.0 4577.8 4580.8 4592.5 4600.6 4385.8 4467.2 4496.2 4500.2 4589.9 4412.2 4506.9 4561.7 4565.1 4575.2 4532.5 4533.9 4540.2 4548.5 4570.5 4021.8 4029.1 4032.7 4037.4 4047.9 5440.8 5576.8 5578.6 5608.3 5613.5 5156.2 5167.9 5171.9 5176.7 5177.4 5894.8 6223.7 6225.8 6247.0 6270.6 4247.0 4255.8 4359.8 4365.3 4377.2 6397.5 6473.6 6484.5 6487.5 6506.2 4466.5 4474.0 4477.6 4484.3 4484.3 4447.7 4513.0 4518.5 4537.4 4562.3 5225.5 5236.4 5236.5 5243.8 5246.0 6271.7 6285.2 6285.7 6286.1 6291.4 1584.8 1605.1 1605.3 1606.6 1606.9 1055.9 1061.5 1080.0 1081.6 1091.7 5931.1 5931.4 5937.1 5939.5 5951.9 6459.0 6463.4 6472.0 6475.9 6477.4 5947.0 5948.3 5950.2 5951.8 5953.3 3408.3 3519.3 3524.7 3524.7 3525.7 6811.8 6816.1 6817.8 6821.2 6823.7 6676.7 6680.5 6684.3 6688.4 6693.9 6611.8 6796.4 6796.7 6800.7 6801.4 6220.0 6356.3 6458.7 6519.9 6537.7 6246.8 6383.9 6396.9 6424.2 6432.4 6648.2 6763.9 6774.7 6780.0 6847.6 4483.2 4569.9 4617.6 4629.4 4640.4 6453.8 6455.6 6456.5 6457.8 6467.5 6286.5 6293.1 6293.6 6293.8 6294.2 6158.5 6198.1 6272.3 6280.9 6286.3 6148.4 6158.8 6165.8 6168.3 6172.7 6253.0 6293.5 6303.8 6307.1 6309.2 6067.9 6119.8 6155.0 6155.9 6163.8 19:23:56 INFO - PROCESS | 4460 | 19:23:56 INFO - PROCESS | 4460 | [#5] yui.html Cycles:180 Average:13410.81 Median:45220.77 stddev:15593.58 (34.5%) stddev-sans-first:15608.65 19:23:56 INFO - PROCESS | 4460 | Values: 818.5 820.0 823.9 828.3 860.2 12650.3 12688.7 12770.9 12817.4 12830.2 11709.6 11745.8 11774.8 11776.6 11787.0 785.9 792.2 792.4 793.0 798.2 639.8 651.8 653.5 653.6 797.2 673.3 819.0 833.2 839.3 840.3 823.3 833.2 834.2 834.3 835.2 494.2 503.9 599.8 614.9 617.3 12334.8 12472.1 12472.6 12541.9 12546.2 11580.1 11886.3 11961.7 12316.8 12320.1 10321.5 10516.2 10565.9 10583.3 10918.5 3588.7 3620.6 3667.9 3668.2 3722.1 43333.1 43384.0 43398.3 43703.6 43934.6 9195.0 9405.1 9510.6 9531.6 9679.2 15278.8 15335.8 17596.5 17683.3 17825.3 7301.9 7394.0 7488.4 7503.0 7608.6 4017.8 4052.9 4084.3 4100.1 4169.0 3143.3 3161.1 3165.9 3180.9 3184.2 548.6 561.5 566.0 574.0 575.8 493.3 617.9 630.3 641.4 646.9 8975.4 9129.8 9232.0 9276.5 9430.4 504.0 508.3 534.0 537.2 544.6 3767.7 3802.1 3918.7 3970.8 4182.1 54469.0 57820.0 57859.0 57942.0 59765.0 49963.0 51313.5 51554.5 51619.2 51872.0 43941.8 44523.3 44899.6 45048.0 45367.8 8402.4 8420.5 8843.5 8914.3 8916.3 33587.8 33798.8 34352.0 34657.8 34757.7 41994.6 45073.8 45513.0 45532.5 45578.0 10193.0 10780.8 10792.6 10805.7 10806.3 11385.2 11448.3 11665.0 11711.4 11952.3 10662.5 10677.5 10791.6 10830.2 12117.6 10915.7 10928.1 11082.6 11478.7 11656.9 10584.1 11031.9 11242.9 11305.5 11331.3 9110.0 9338.9 9344.3 9350.8 9431.1 9123.0 9296.3 9613.2 9835.9 9842.8 19:23:56 INFO - PROCESS | 4460 | -------- Summary: end -------- 19:23:56 INFO - PROCESS | 4460 | 19:23:57 INFO - TEST-INFO | 4460: exit 0 19:23:57 INFO - TEST-OK | dromaeo_css | took 1111956ms 19:23:57 INFO - TEST-START | kraken 19:23:57 INFO - operating with platform_type : linux_ 19:23:57 INFO - Initialising browser for kraken test... 19:23:57 INFO - TEST-INFO | started process 4649 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOSDAz/profile http://localhost:36692/getInfo.html) 19:24:01 INFO - PROCESS | 4649 | __metrics Screen width/height:1600/1200 19:24:01 INFO - PROCESS | 4649 | colorDepth:24 19:24:01 INFO - PROCESS | 4649 | Browser inner width/height: 1024/697 19:24:01 INFO - PROCESS | 4649 | __metrics 19:24:01 INFO - PROCESS | 4649 | 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 - PROCESS | 4649 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:24:02 INFO - TEST-INFO | 4649: exit 0 19:24:02 INFO - Browser initialized. 19:24:02 INFO - Running cycle 1/1 for kraken test... 19:24:02 INFO - TEST-INFO | started process 4733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaOSDAz/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:14 INFO - PROCESS | 4733 | RSS: Main: 149463040 19:24:14 INFO - PROCESS | 4733 | 19:24:16 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36692/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:17 INFO - PROCESS | 4733 | RSS: Main: 186429440 19:24:17 INFO - PROCESS | 4733 | 19:24:20 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36692/tests/kraken/driver.html?testName=audio-dft) 19:24:20 INFO - PROCESS | 4733 | RSS: Main: 176033792 19:24:20 INFO - PROCESS | 4733 | 19:24:23 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36692/tests/kraken/driver.html?testName=audio-fft) 19:24:24 INFO - PROCESS | 4733 | RSS: Main: 161849344 19:24:24 INFO - PROCESS | 4733 | 19:24:26 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36692/tests/kraken/driver.html?testName=audio-oscillator) 19:24:26 INFO - PROCESS | 4733 | RSS: Main: 163500032 19:24:26 INFO - PROCESS | 4733 | 19:24:28 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:24:29 INFO - PROCESS | 4733 | RSS: Main: 165277696 19:24:29 INFO - PROCESS | 4733 | 19:24:32 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36692/tests/kraken/driver.html?testName=imaging-darkroom) 19:24:33 INFO - PROCESS | 4733 | RSS: Main: 165691392 19:24:33 INFO - PROCESS | 4733 | 19:24:36 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36692/tests/kraken/driver.html?testName=imaging-desaturate) 19:24:36 INFO - PROCESS | 4733 | RSS: Main: 167305216 19:24:36 INFO - PROCESS | 4733 | 19:24:39 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36692/tests/kraken/driver.html?testName=json-parse-financial) 19:24:40 INFO - PROCESS | 4733 | RSS: Main: 165728256 19:24:40 INFO - PROCESS | 4733 | 19:24:41 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:24:42 INFO - PROCESS | 4733 | RSS: Main: 175984640 19:24:42 INFO - PROCESS | 4733 | 19:24:44 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:24:44 INFO - PROCESS | 4733 | RSS: Main: 173043712 19:24:44 INFO - PROCESS | 4733 | 19:24:46 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:24:47 INFO - PROCESS | 4733 | RSS: Main: 184500224 19:24:47 INFO - PROCESS | 4733 | 19:24:49 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:24:50 INFO - PROCESS | 4733 | RSS: Main: 190853120 19:24:50 INFO - PROCESS | 4733 | 19:24:52 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:53 INFO - PROCESS | 4733 | RSS: Main: 188985344 19:24:53 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | Cycle 1(1): loaded http://localhost:36692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36692/tests/kraken/driver.html?testName=ai-astar) 19:24:55 INFO - PROCESS | 4733 | RSS: Main: 247136256 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | __start_tp_report 19:24:55 INFO - PROCESS | 4733 | _x_x_mozilla_page_load 19:24:55 INFO - PROCESS | 4733 | _x_x_mozilla_page_load_details 19:24:55 INFO - PROCESS | 4733 | |i|pagename|runs| 19:24:55 INFO - PROCESS | 4733 | |0;ai-astar;109;109;104;109;109;109;100;110;108;108 19:24:55 INFO - PROCESS | 4733 | |1;audio-beat-detection;149;125;151;163;127;151;152;127;164;138 19:24:55 INFO - PROCESS | 4733 | |2;audio-dft;162;159;160;162;160;163;160;162;161;160 19:24:55 INFO - PROCESS | 4733 | |3;audio-fft;72;75;101;90;74;72;71;106;98;72 19:24:55 INFO - PROCESS | 4733 | |4;audio-oscillator;95;96;144;96;96;96;144;96;96;139 19:24:55 INFO - PROCESS | 4733 | |5;imaging-gaussian-blur;110;110;109;109;109;109;111;109;110;109 19:24:55 INFO - PROCESS | 4733 | |6;imaging-darkroom;146;146;146;145;147;146;145;146;145;145 19:24:55 INFO - PROCESS | 4733 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;96 19:24:55 INFO - PROCESS | 4733 | |8;json-parse-financial;57;56;55;56;55;54;56;65;54;54 19:24:55 INFO - PROCESS | 4733 | |9;json-stringify-tinderbox;70;69;69;69;69;69;69;69;69;70 19:24:55 INFO - PROCESS | 4733 | |10;stanford-crypto-aes;82;82;81;81;81;81;81;82;82;81 19:24:55 INFO - PROCESS | 4733 | |11;stanford-crypto-ccm;113;121;115;116;120;117;120;121;122;120 19:24:55 INFO - PROCESS | 4733 | |12;stanford-crypto-pbkdf2;146;143;143;139;142;133;141;138;143;140 19:24:55 INFO - PROCESS | 4733 | |13;stanford-crypto-sha256-iterative;66;67;65;66;66;64;65;66;65;67 19:24:55 INFO - PROCESS | 4733 | __end_tp_report 19:24:55 INFO - PROCESS | 4733 | __start_cc_report 19:24:55 INFO - PROCESS | 4733 | _x_x_mozilla_cycle_collect,941 19:24:55 INFO - PROCESS | 4733 | __end_cc_report 19:24:55 INFO - PROCESS | 4733 | __startTimestamp1452828295326__endTimestamp 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | ------- Summary: start ------- 19:24:55 INFO - PROCESS | 4733 | Number of tests: 14 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#0] ai-astar Cycles:10 Average:107.50 Median:109.00 stddev:3.10 (2.8%) stddev-sans-first:3.24 19:24:55 INFO - PROCESS | 4733 | Values: 109.0 109.0 104.0 109.0 109.0 109.0 100.0 110.0 108.0 108.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.00 stddev:14.60 (9.7%) stddev-sans-first:15.40 19:24:55 INFO - PROCESS | 4733 | Values: 149.0 125.0 151.0 163.0 127.0 151.0 152.0 127.0 164.0 138.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 19:24:55 INFO - PROCESS | 4733 | Values: 162.0 159.0 160.0 162.0 160.0 163.0 160.0 162.0 161.0 160.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#3] audio-fft Cycles:10 Average:83.10 Median:73.00 stddev:14.06 (19.3%) stddev-sans-first:14.33 19:24:55 INFO - PROCESS | 4733 | Values: 72.0 75.0 101.0 90.0 74.0 72.0 71.0 106.0 98.0 72.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:96.00 stddev:22.49 (23.4%) stddev-sans-first:23.21 19:24:55 INFO - PROCESS | 4733 | Values: 95.0 96.0 144.0 96.0 96.0 96.0 144.0 96.0 96.0 139.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 19:24:55 INFO - PROCESS | 4733 | Values: 110.0 110.0 109.0 109.0 109.0 109.0 111.0 109.0 110.0 109.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 19:24:55 INFO - PROCESS | 4733 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 145.0 146.0 145.0 145.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 19:24:55 INFO - PROCESS | 4733 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.26 (5.8%) stddev-sans-first:3.44 19:24:55 INFO - PROCESS | 4733 | Values: 57.0 56.0 55.0 56.0 55.0 54.0 56.0 65.0 54.0 54.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 19:24:55 INFO - PROCESS | 4733 | Values: 70.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 69.0 70.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 19:24:55 INFO - PROCESS | 4733 | Values: 82.0 82.0 81.0 81.0 81.0 81.0 81.0 82.0 82.0 81.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:120.00 stddev:3.03 (2.5%) stddev-sans-first:2.47 19:24:55 INFO - PROCESS | 4733 | Values: 113.0 121.0 115.0 116.0 120.0 117.0 120.0 121.0 122.0 120.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.80 Median:142.50 stddev:3.58 (2.5%) stddev-sans-first:3.27 19:24:55 INFO - PROCESS | 4733 | Values: 146.0 143.0 143.0 139.0 142.0 133.0 141.0 138.0 143.0 140.0 19:24:55 INFO - PROCESS | 4733 | 19:24:55 INFO - PROCESS | 4733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 19:24:55 INFO - PROCESS | 4733 | Values: 66.0 67.0 65.0 66.0 66.0 64.0 65.0 66.0 65.0 67.0 19:24:55 INFO - PROCESS | 4733 | -------- Summary: end -------- 19:24:55 INFO - PROCESS | 4733 | 19:24:56 INFO - TEST-INFO | 4733: exit 0 19:24:56 INFO - TEST-OK | kraken | took 58555ms 19:24:56 INFO - TEST-START | v8_7 19:24:56 INFO - operating with platform_type : linux_ 19:24:56 INFO - Initialising browser for v8_7 test... 19:24:56 INFO - TEST-INFO | started process 4983 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnJbEF6/profile http://localhost:36692/getInfo.html) 19:25:00 INFO - PROCESS | 4983 | __metrics Screen width/height:1600/1200 19:25:00 INFO - PROCESS | 4983 | colorDepth:24 19:25:00 INFO - PROCESS | 4983 | Browser inner width/height: 1024/697 19:25:00 INFO - PROCESS | 4983 | __metrics 19:25:00 INFO - PROCESS | 4983 | 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:00 INFO - PROCESS | 4983 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:25:01 INFO - TEST-INFO | 4983: 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 5065 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnJbEF6/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:12 INFO - PROCESS | 5065 | RSS: Main: 150282240 19:25:12 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | Cycle 1(1): loaded http://localhost:36692/tests/v8_7/run.html (next: http://localhost:36692/tests/v8_7/run.html) 19:25:35 INFO - PROCESS | 5065 | RSS: Main: 592244736 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | __start_tp_report 19:25:35 INFO - PROCESS | 5065 | _x_x_mozilla_page_load 19:25:35 INFO - PROCESS | 5065 | _x_x_mozilla_page_load_details 19:25:35 INFO - PROCESS | 5065 | |i|pagename|runs| 19:25:35 INFO - PROCESS | 5065 | |0;Richards;167.36401673640168 19:25:35 INFO - PROCESS | 5065 | |1;DeltaBlue;187.6172607879925 19:25:35 INFO - PROCESS | 5065 | |2;Encrypt;279.56388034665923 19:25:35 INFO - PROCESS | 5065 | |3;Decrypt;5251.308900523561 19:25:35 INFO - PROCESS | 5065 | |4;RayTrace;1960.7843137254902 19:25:35 INFO - PROCESS | 5065 | |5;Earley;768.6395080707148 19:25:35 INFO - PROCESS | 5065 | |6;Boyer;12345.67901234568 19:25:35 INFO - PROCESS | 5065 | |7;RegExp;41653.06122448979 19:25:35 INFO - PROCESS | 5065 | |8;Splay;619.6054254007398 19:25:35 INFO - PROCESS | 5065 | |9;NavierStokes;4835.748792270531 19:25:35 INFO - PROCESS | 5065 | __end_tp_report 19:25:35 INFO - PROCESS | 5065 | __startTimestamp1452828335729__endTimestamp 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | ------- Summary: start ------- 19:25:35 INFO - PROCESS | 5065 | Number of tests: 10 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 167.4 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#1] DeltaBlue Cycles:1 Average:187.62 Median:187.62 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 187.6 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 279.6 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 5251.3 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 1960.8 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#5] Earley Cycles:1 Average:768.64 Median:768.64 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 768.6 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 12345.7 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#7] RegExp Cycles:1 Average:41653.06 Median:41653.06 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 41653.1 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#8] Splay Cycles:1 Average:619.61 Median:619.61 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 619.6 19:25:35 INFO - PROCESS | 5065 | 19:25:35 INFO - PROCESS | 5065 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:25:35 INFO - PROCESS | 5065 | Values: 4835.7 19:25:35 INFO - PROCESS | 5065 | -------- Summary: end -------- 19:25:35 INFO - PROCESS | 5065 | 19:25:36 INFO - TEST-INFO | 5065: exit 0 19:25:36 INFO - TEST-OK | v8_7 | took 40443ms 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,35]] 19:25:36 INFO - process_Request line: dromaeo_css 6791.14 graph.html#tests=[[72,64,35]] 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 1488.50 graph.html#tests=[[232,64,35]] 19:25:36 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:25:36 INFO - process_Request line: v8_7 18926.96 graph.html#tests=[[230,64,35]] 19:25:36 INFO - RETURN: dromaeo_css: 6791.14 19:25:36 INFO - RETURN: kraken: 1488.50 19:25:36 INFO - RETURN: v8_7: 18926.96 19:25:36 INFO - javascript benchmark 19:25:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3114.563961045454, 3139.7331226845718, 3181.125190572592, 3185.028566287283, 3204.791688540244, 4970.652054356187, 5038.370203724535, 5089.770960306786, 5098.515641014107, 5147.819826306075, 4929.457759646436, 4963.950360496394, 5053.242013697938, 5112.769925353358, 5133.9229911551265, 4579.771011449422, 4594.287885377772, 4605.332226827108, 4656.7205967641885, 4669.649776266777, 549.7986974670066, 4581.816727330903, 4587.977060114695, 4602.516735742749, 4697.107549565589, 4587.678862479628, 4602.815887364518, 4629.722216667011, 4631.930521042187, 4650.372199753041, 4683.110209060268, 4683.7892294846815, 4684.742339171345, 4711.552402521755, 4728.054389122155, 4564.064366804797, 4628.83799067031, 4647.442306923157, 4680.0, 4686.53134686532, 4903.166461701519, 4917.532834380728, 4930.531599498042, 4949.950500494985, 4965.776540055706, 5394.595405344615, 5405.405405405402, 5405.567554595662, 5427.0773968425465, 5447.618666693294, 5277.894442111136, 5350.705711185883, 5453.072977593779, 5464.644798088151, 5524.668519888779, 5105.438401775802, 5114.590832733373, 5116.488351164854, 5121.129408000612, 5166.328377310925, 5529.529989950819, 5538.529225015838, 5541.196526503634, 5541.307336582927, 5558.833235002957, 5252.579793616502, 5328.49379308965, 5361.437049109865, 5368.946310536923, 5436.728163591804, 5460.180972854104, 5469.890602187934, 5474.069408200616, 5477.698726570077, 5479.808206712746, 5317.521423071942, 5443.183522471661, 5444.8094316698725, 5453.318335208099, 5487.0, 5224.738763061831, 5442.972785136049, 5457.945420545823, 5478.863028424321, 5515.310586176728, 4267.0825772459075, 4283.400323954649, 4285.46431696038, 4292.270314046619, 4325.134973005412, 3766.265578212277, 3841.2893614681375, 3850.6726928210855, 3866.9613303867163, 3874.6706529945272, 5095.286659867622, 5112.258722485219, 5132.56373208274, 5133.948660513422, 5174.43081261061, 5464.9453505465235, 5507.752151153208, 5534.391216966131, 5534.418886016991, 5576.888462230732, 5011.523905228997, 5062.898742025139, 5103.540681338697, 5122.257272695439, 5138.023775482647, 4718.740469274223, 4733.148033354029, 4737.668363214542, 4759.833405830779, 4780.521947805191, 5724.685142317129, 5727.5131613812455, 5728.914066289009, 5729.369769325371, 5729.570282228766, 5420.7560659769615, 5485.9725701371235, 5497.917531237114, 5514.117741161555, 5587.69267690281, 5614.382417934105, 5624.268845050117, 5648.915266270927, 5654.321481422256, 5665.376808551138, 5370.731463426891, 5376.462353764592, 5377.637773262614, 5378.489043541014, 5403.324584426947, 5377.542908852792, 5389.434109418455, 5412.458754124714, 5448.782048718007, 5471.452854714496, 5357.491038351351, 5377.112776391851, 5383.08487557124, 5393.892122157614, 5394.892102157856, 5155.561777248976, 5356.491133342326, 5376.193570964387, 5377.27406800077, 5392.757325920422, 5142.922856157086, 5297.073012222922, 5338.652987555796, 5368.973155134199, 5393.029254734185, 5359.330083739533, 5364.8122315718765, 5374.973125134349, 5379.381371142369, 5380.192971054216, 5242.737863106906, 5270.789168433374, 5272.209168624737, 5312.920306195488, 5313.362396512443], "unit": "score", "name": "dojo.html", "value": 5014.506457036876}, {"lowerIsBetter": false, "replicates": [525.7739172155973, 543.2123421039494, 565.4430386069718, 575.9948889188366, 585.7861880413649, 27866.30334241645, 28548.57177142342, 28565.57151642727, 34689.65310346902, 35369.82315088427, 38640.80679596598, 39114.0, 39146.28110329514, 39168.41247381292, 39198.21603567927, 8532.317414606847, 8871.512066836322, 8881.378303518757, 8885.42244754089, 8887.377883548153, 8537.573121343908, 8698.347623928199, 8707.95646021769, 8709.433886797338, 8712.651493940235, 8680.305575553972, 8764.693235736751, 8767.254783343424, 8769.254613357873, 8774.298056155525, 8617.0, 8700.912990870074, 8707.390482666216, 8722.08418116095, 8724.432911860773, 8531.360147988926, 8632.266257368132, 8680.435771674884, 8688.913110868874, 8690.261327787082, 38120.80939595284, 38536.42195367072, 38756.61243387587, 38890.416643750366, 38952.61047389518, 3102.829344386058, 3166.0501849445304, 3227.273863380744, 3460.2560449503476, 3926.666233370167, 28668.569971450444, 28881.277968050756, 29711.70288297111, 29982.400351993056, 30130.54804177939, 3641.198936234024, 3663.19409729859, 3673.246984368198, 3743.3074881146804, 3872.3997780344093, 275867.0, 276531.0, 277869.0, 278063.0, 278311.0, 56660.71669641625, 56902.715486422305, 56987.430125699044, 56999.43000570024, 57120.14319785206, 59472.70263648654, 59692.0, 59729.701351492964, 59762.0, 59781.402185978455, 14864.62838429048, 15158.090514569161, 15195.088294702353, 15201.6199595011, 15207.695846083237, 11755.706107347385, 11810.232334898204, 11830.0, 11830.231034982698, 11833.881661183277, 17955.281788728305, 18392.540186495444, 18465.507156533964, 18485.260589576268, 18488.35290764817, 7184.928150718426, 7261.128664560287, 7355.227701091415, 7374.225706300761, 7411.444141689287, 858.8969323681198, 890.8619164029586, 912.7489940266347, 979.2557656181353, 1016.4358780876685, 24433.755662443502, 24857.25428237156, 24912.750872491044, 27969.580456293173, 28670.42659146847, 879.9322976724911, 932.8320902237526, 982.1308142293979, 983.1790454970037, 995.6764051683087, 12149.210301330386, 13054.21674699502, 13275.535356262677, 13313.800292995613, 13327.600171994856, 323032.0, 323372.0, 325584.0, 327682.0, 328048.0, 41015.923805714694, 41763.7911810439, 46520.0, 47519.5248047522, 49020.0, 1303.2050449225965, 1311.8294621699308, 1316.0327159537733, 1316.1839659411226, 1334.2794890758883, 23597.528049439257, 25376.365590860376, 26692.065777697688, 26841.731582684704, 26970.460590788465, 40112.39831402589, 46951.29573056338, 47438.76280618575, 47731.0, 47741.283880741124, 198864.0, 200350.0, 200733.0, 200845.0, 200865.0, 28408.147755567366, 28523.42953140967, 28552.143435696962, 28971.420571588027, 29040.273993150342, 40378.39432408575, 43221.3516797242, 43287.56712432835, 44271.77864110659, 44439.33340999823, 36398.8180059098, 36695.63304366922, 37328.25343493061, 37560.0, 37993.0, 35609.28781424409, 36113.0, 36243.63756362403, 36539.63460365469, 36994.8150259247, 35788.82105589456, 35933.28133437369, 36030.4595431074, 36100.81949590235, 36778.63221367752, 30706.232344191572, 30948.0, 31062.602182901373, 31492.842535787175, 31782.0, 23715.40711482227, 24075.73084362498, 24197.0, 24351.878240608683, 24384.0], "unit": "score", "name": "ext.html", "value": 17610.57875925762}, {"lowerIsBetter": false, "replicates": [362.213995629484, 362.4147002590816, 363.7762775892826, 366.94312381580863, 369.20068052665977, 12854.614361569145, 12887.851958203704, 15512.84487155128, 16586.25361858716, 17605.559861003465, 13572.660683482893, 14054.859451405482, 14483.131012139253, 14498.13011219325, 14947.850521494782, 5145.382554093505, 5349.5720342372515, 5354.170103633943, 5356.464353564632, 5363.865903352428, 3926.6858651307825, 4041.2725709372303, 5311.362636483608, 5402.729863506828, 5477.7261136943, 5708.943845388596, 5809.651420914737, 5860.648361098348, 5862.530997520188, 5866.73599688015, 5689.943100568983, 5811.912821307642, 5820.272465941757, 5825.650460972334, 5838.795642152526, 5002.424721157077, 5153.149730294497, 5154.149565321717, 5221.112410890158, 5228.137357336035, 18884.0, 19396.903015484975, 19732.21071157152, 20081.698774518394, 20424.79575204244, 2032.1160295271457, 2200.460887082659, 2261.513774538466, 2394.4253379188867, 2867.956980645292, 12649.557265495756, 12768.872311276862, 12865.16376435538, 12890.355482225852, 13100.934495327558, 1890.3383815664545, 1914.838760858351, 1941.0682872221412, 1996.6605677034938, 2002.909869055896, 61276.69361653208, 62221.37778622201, 63861.680691596244, 63955.0, 64285.03572446417, 14774.926125369304, 14775.556733298019, 14812.11127332342, 14838.703225935637, 14850.777238341434, 22577.09691612317, 22618.66072008921, 23087.653685194735, 23165.652515211947, 23172.65241021386, 8768.561571921506, 8772.649094036167, 8857.867131993025, 8868.689595864114, 8924.152205540464, 7432.070991126109, 7478.3643390311345, 7482.176960534337, 7509.887351689729, 7510.662020208994, 7375.44684148691, 7462.813429664302, 7478.401727861758, 7494.100707914976, 7603.315701586884, 1784.9018303993146, 1814.7640806695044, 1819.1904602452046, 1835.8072402397822, 2139.935801925945, 869.5130726793017, 885.3094586222628, 896.9058248883904, 997.4065431068502, 1012.5645972231864, 14096.85903140976, 15311.387544498319, 15492.14793186363, 15728.292226849819, 16853.59712588196, 898.9190972812478, 901.6348378906554, 960.0687333286701, 977.1986970683971, 1019.6278358399131, 8733.475991440533, 9064.818703625891, 9066.95466522663, 9197.356185066981, 9271.582778774971, 345222.0, 481755.0, 563136.0, 569457.3054269404, 571383.0, 65212.0, 66148.6692566534, 68072.0, 69914.65042674754, 74478.25521744713, 1017.9032991865909, 1039.5270152080784, 1054.0355574649263, 1054.414799786126, 1062.9627963021258, 13517.256550889795, 13826.446942122202, 14060.789088163481, 14111.647208819862, 14913.105213687213, 26971.0, 28766.856165719037, 32552.186195345304, 32580.0, 34058.82970585131, 43811.780941095094, 44607.0, 45345.77327113343, 45360.54639453563, 45505.31742023806, 6642.701078451385, 6873.656317184221, 6879.484038697017, 6890.138732658418, 7058.25888281723, 9341.859872101788, 10273.486325683836, 10553.683389498021, 10590.417527036087, 10726.839097413702, 9264.490453024879, 9284.860727089233, 9353.20497757671, 9527.0, 9553.092456216647, 8916.910830891868, 9252.545146193585, 9321.254299655875, 9333.53332333367, 9614.95192524033, 9262.536873156181, 9311.255099591881, 9401.576929038347, 9646.90353096488, 9742.0, 6931.202911665021, 7004.124484439445, 7205.0, 7236.565806051653, 7261.092363454568, 8453.154684531497, 8601.354898382771, 8775.561221939006, 8790.989036260657, 8827.779305517157], "unit": "score", "name": "jquery.html", "value": 8479.441840370266}, {"lowerIsBetter": false, "replicates": [1258.8929940955018, 1382.2052319916047, 1385.5566218809981, 1504.8720858727008, 1733.5178422448805, 6866.588004719721, 7450.813729656755, 7576.77269681909, 7590.127135379433, 7590.658420371083, 7732.304092631662, 7916.960415197916, 7924.207579242073, 7924.6433910474025, 7928.722494712686, 1971.2115153938469, 1993.1329871505868, 2283.3834864586634, 2300.7584203658585, 2341.6487526870937, 2318.038014224095, 2322.976770232293, 2327.034280773477, 2327.5810354136247, 2338.9766102339013, 2236.7875051870046, 2316.652502124686, 2316.7104111986, 2317.432229103872, 2318.385627808632, 2263.592553340398, 2295.104909085458, 2302.930912072624, 2305.4236440889777, 2305.9769402306015, 2272.8863556822257, 2280.9543809123725, 2297.414159389362, 2301.827362947786, 2303.0672577606097, 8008.919910800876, 8081.272685458278, 8083.393745469113, 8083.555404452753, 8086.838263234761, 4756.571908528214, 4914.91871788206, 4916.606671466274, 4920.089783390084, 4943.505649435064, 3091.335362896988, 3144.874205031796, 3204.7275981541598, 3225.080851957181, 3231.644519102897, 1015.3856916565445, 1020.1277907389224, 1046.1473898772476, 1050.7583255851198, 1073.1093192650083, 11142.164337674625, 11315.038221751161, 11322.490487928064, 11336.603218887381, 11355.432228388547, 4426.9778651106535, 4511.278195488706, 4517.232070548015, 4536.591706746409, 4547.295169248771, 8877.73366798997, 8915.37592368528, 8954.955225223963, 8956.193942545202, 8956.776080598038, 4914.852554423373, 4939.0, 4942.406911170682, 4945.332380128709, 4952.232403977389, 4481.910361792746, 4522.140793249338, 4537.705049171794, 4567.13224487353, 4568.588827005586, 3332.600087989408, 3381.8309084545676, 3416.3338149060696, 3610.0433385152955, 3696.8890933271505, 1077.1436707817304, 1079.3146352066337, 1092.6121226964312, 1105.867295924494, 1106.076426184129, 1248.7939489984233, 1270.4498723590289, 1281.8718128187106, 1320.0957344219048, 1320.8348956380453, 7430.071241094864, 7455.2172021938, 7476.5514069156025, 7476.962615186998, 7484.476086673881, 1152.827075938616, 1160.6808127764764, 1186.1815347410259, 1198.0774803401332, 1208.2146604707011, 5733.71331433435, 5770.394108618619, 5836.949349117115, 5852.268466441695, 5861.589688721834, 9089.318301127441, 9328.347015708836, 9419.670311539201, 9561.0, 9577.0, 9370.34407591462, 9403.670871519464, 9417.576209070608, 9440.055994400505, 9444.150026497511, 7224.096987876515, 7400.814979625552, 7486.43851711113, 7486.775396737998, 7488.326050655467, 7035.859282814417, 7077.327653872874, 7088.291170882871, 7148.820444626578, 7152.0, 8332.791680208044, 8376.706815261437, 8450.408471406943, 8548.974123105267, 8555.529445880537, 8484.236418722345, 8759.16787905148, 8765.474071555727, 8771.956140219514, 8775.341849361195, 6932.896006559805, 7059.682314295766, 7074.929250707427, 7169.964150179216, 7189.7483588074165, 6663.700133493908, 6804.863902722017, 7301.196868344584, 7541.811454713676, 7551.244875512405, 6891.689873955785, 7069.434445244471, 7110.040144580622, 7137.321954414322, 7318.817029574303, 6924.619145947021, 6973.79078627642, 7010.894836577558, 7070.964645176741, 7118.715251389886, 6931.4108300795, 6965.477589180933, 6980.232174460703, 6982.546134501241, 6985.196702379291, 6234.625922444668, 6273.1844860167885, 6280.340564240872, 6288.151099601679, 6312.5265605078885, 6631.3700198481065, 6677.565958212701, 6684.4318232950745, 6815.93184068153, 6830.829229269308], "unit": "score", "name": "mootools.html", "value": 4538.9911450261525}, {"lowerIsBetter": false, "replicates": [342.1258684062221, 349.4164744876057, 350.9263054758501, 351.19400974762925, 351.195761705694, 5716.685582292972, 5823.592348535604, 5882.647041177533, 5910.586258961875, 5914.172015917769, 5656.91514627281, 5829.921464529065, 5835.35811060784, 5848.736806843692, 5858.589898707092, 4574.0, 4577.793999270041, 4580.770961451914, 4592.517785632511, 4600.585947264745, 4385.8464953726625, 4467.15124126415, 4496.213162696531, 4500.189965806154, 4589.885252868671, 4412.183746006983, 4506.909861802762, 4561.703489273186, 4565.132624801277, 4575.22221222393, 4532.501424843264, 4533.9319910201375, 4540.18276710192, 4548.499665036843, 4570.474395444533, 4021.8391264349393, 4029.0531725044593, 4032.737872038308, 4037.4347591337237, 4047.9190416191805, 5440.836774896759, 5576.804811831607, 5578.581606379537, 5608.327000759935, 5613.522850557708, 5156.20078887773, 5167.896642067138, 5171.896562068775, 5176.6893986360565, 5177.37871455424, 5894.793682221101, 6223.719932602999, 6225.8132256032395, 6247.031710084899, 6270.561060725751, 4246.978765106154, 4255.829766809324, 4359.8446411700925, 4365.3451982202605, 4377.23398405281, 6397.52018598607, 6473.611583305017, 6484.481241500669, 6487.481001519915, 6506.186726659168, 4466.4640243171025, 4474.038081812361, 4477.574630410106, 4484.304932735431, 4484.349769283501, 4447.688661793708, 4513.0, 4518.548145185521, 4537.3647689323525, 4562.292844609091, 5225.529702326809, 5236.371635403776, 5236.450172731885, 5243.8164664236565, 5245.973770131125, 6271.686415679198, 6285.245770507477, 6285.654289014148, 6286.088517164985, 6291.402316779899, 1584.7939767830107, 1605.069059945229, 1605.2615796733633, 1606.5903194685513, 1606.9276882540314, 1055.9260851740305, 1061.527620209015, 1079.9892001080045, 1081.6376513867785, 1091.7106966653844, 5931.139984702194, 5931.406859314034, 5937.050071988548, 5939.46544810969, 5951.9107213391835, 6459.0, 6463.353664633499, 6471.9676401618635, 6475.935240647627, 6477.384648458389, 5947.0, 5948.256467941507, 5950.2264705587995, 5951.761929522857, 5953.285605727254, 3408.301298233856, 3519.278547897726, 3524.6827785499427, 3524.7356448266482, 3525.7179425645886, 6811.829704257433, 6816.113905192294, 6817.761378351833, 6821.21556021054, 6823.727050918007, 6676.666166691646, 6680.532362734659, 6684.2647308795995, 6688.398044176048, 6693.899591506131, 6611.801645950629, 6796.35434633709, 6796.728130874809, 6800.6939687714175, 6801.387875091265, 6220.0, 6356.300806911144, 6458.677066146768, 6519.934800651933, 6537.673116344259, 6246.781362652286, 6383.904241436475, 6396.904046439214, 6424.196975378078, 6432.421082102634, 6648.16897887764, 6763.898541521783, 6774.661266936535, 6780.0, 6847.62338071391, 4483.193025255486, 4569.862904112882, 4617.584417402316, 4629.351890735233, 4640.443146822403, 6453.838654033687, 6455.644939528371, 6456.54804163704, 6457.773977910751, 6467.450266727381, 6286.465650419766, 6293.118963345044, 6293.559450838397, 6293.842653933688, 6294.213223347082, 6158.538109641705, 6198.101275315144, 6272.310045895039, 6280.874382512416, 6286.308506064421, 6148.385161483995, 6158.815235542941, 6165.784197553064, 6168.321484636776, 6172.6913654318005, 6253.0, 6293.527985401021, 6303.779367722108, 6307.148534947723, 6309.179806625109, 6067.908981365194, 6119.755209791559, 6155.045967874987, 6155.938440615537, 6163.753449861955], "unit": "score", "name": "prototype.html", "value": 4743.000514318126}, {"lowerIsBetter": false, "replicates": [818.4843548564407, 819.983600327993, 823.851706692795, 828.2669837194084, 860.238688760447, 12650.304233267167, 12688.682782930407, 12770.93614531926, 12817.42321595527, 12830.166039207445, 11709.59016434425, 11745.823812642817, 11774.764504709901, 11776.646700598996, 11787.0, 785.9017622797136, 792.2038351456778, 792.3621484704811, 793.028540038454, 798.1938242375185, 639.7984634840011, 651.7881688451249, 653.5294587896731, 653.584973541802, 797.1709422200933, 673.2896793882452, 818.9877151842727, 833.1793183714037, 839.2656425627575, 840.306746933782, 823.3372135430976, 833.1668331668332, 834.2491757418311, 834.2991886815043, 835.1523203947997, 494.1944630252665, 503.8639567316841, 599.7990673124508, 614.923134608174, 617.2623714660982, 12334.81497777534, 12472.126951113425, 12472.563460278938, 12541.874581254162, 12546.247225166519, 11580.073594112451, 11886.28682279066, 11961.700957476045, 12316.81524777129, 12320.137590368679, 10321.535530901052, 10516.211284153642, 10565.89058148891, 10583.31208471447, 10918.50866711, 3588.730845186595, 3620.6379362063844, 3667.9083022924374, 3668.248009158116, 3722.1066943933533, 43333.13333733339, 43384.0, 43398.349024764655, 43703.56296437027, 43934.56065439337, 9195.0, 9405.11216900023, 9510.619575217052, 9531.571079301448, 9679.177269932135, 15278.847211527742, 15335.846641533664, 17596.472105836845, 17683.292668293383, 17825.286988520573, 7301.89047164293, 7394.0, 7488.4009279257525, 7502.987096741979, 7608.581528016012, 4017.8191981360324, 4052.8986775330263, 4084.2852500812237, 4100.138970816102, 4169.041120542292, 3143.2613335866054, 3161.1148878314107, 3165.920851978673, 3180.904572862818, 3184.2357834119643, 548.5858177076282, 561.4806304168628, 565.9575531835129, 573.9983728393979, 575.7955925646335, 493.33646245799343, 617.9442656065712, 630.3224034163293, 641.4291280760127, 646.9256035555877, 8975.371723979259, 9129.81740365189, 9232.0, 9276.536173191313, 9430.3870248435, 504.0372887784388, 508.27063164358526, 533.9893202135936, 537.1539824775994, 544.5670691800028, 3767.7362584619364, 3802.1445174835994, 3918.7452815567467, 3970.8014599269923, 4182.100848317566, 54469.0, 57820.0, 57859.0, 57942.0, 59765.0, 49963.0, 51313.48686513162, 51554.48445515572, 51619.22571161436, 51872.0, 43941.78029109898, 44523.328600283436, 44899.55100449019, 45048.0, 45367.773161133984, 8402.411831172003, 8420.494770313555, 8843.46939183651, 8914.28685705155, 8916.25786459311, 33587.83206083954, 33798.83100584481, 34352.0, 34657.826710866284, 34757.65242347544, 41994.58005419907, 45073.77463112663, 45513.0, 45532.544674554156, 45578.0, 10193.0, 10780.838287425539, 10792.622258220925, 10805.729856753644, 10806.255360740393, 11385.17848084874, 11448.313101213955, 11665.0, 11711.355875426592, 11952.342621155572, 10662.520186591466, 10677.519511622151, 10791.6222932197, 10830.241883068109, 12117.636470905887, 10915.727106822393, 10928.125749939827, 11082.61210857616, 11478.713032174262, 11656.88568143056, 10584.100351470212, 11031.889681103086, 11242.943785281348, 11305.547778088785, 11331.263467874562, 9109.954450227706, 9338.859917101114, 9344.299177561574, 9350.812983740423, 9431.104045115702, 9123.0, 9296.256299496159, 9613.182879455046, 9835.901640983499, 9842.75393115178], "unit": "score", "name": "yui.html", "value": 6084.663504434531}], "name": "dromaeo_css", "value": 6791.138585742139}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 104.0, 109.0, 109.0, 109.0, 100.0, 110.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 151.0, 163.0, 127.0, 151.0, 152.0, 127.0, 164.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 159.0, 160.0, 162.0, 160.0, 163.0, 160.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 101.0, 90.0, 74.0, 72.0, 71.0, 106.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 144.0, 96.0, 96.0, 96.0, 144.0, 96.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 111.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 56.0, 55.0, 54.0, 56.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 81.0, 81.0, 81.0, 81.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [113.0, 121.0, 115.0, 116.0, 120.0, 117.0, 120.0, 121.0, 122.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [146.0, 143.0, 143.0, 139.0, 142.0, 133.0, 141.0, 138.0, 143.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 66.0, 64.0, 65.0, 66.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1488.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [187.6172607879925], "unit": "score", "name": "DeltaBlue", "value": 352.4089399999998}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [768.6395080707148], "unit": "score", "name": "Earley", "value": 867.068363}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41653.06122448979], "unit": "score", "name": "RegExp", "value": 21.870781479666846}, {"lowerIsBetter": false, "replicates": [619.6054254007398], "unit": "score", "name": "Splay", "value": 131.5207980099502}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18926.959012434283}]} 19:25:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "18926.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1488.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6791.14"}}} 19:25:36 INFO - Return code: 0 19:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:25:36 INFO - # TBPL SUCCESS # 19:25:36 INFO - Running post-action listener: _resource_record_post_action 19:25:36 INFO - Running post-run listener: _resource_record_post_run 19:25:37 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 539467776; Read time: 312; Write time: 576732 19:25:37 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237232128; Read time: 204; Write time: 310656 19:25:37 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302235648; Read time: 108; Write time: 266076 19:25:37 INFO - Running post-run listener: _upload_blobber_files 19:25:37 INFO - Blob upload gear active. 19:25:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:25:37 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:37 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:37 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_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_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_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_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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1da384930e93a1d9746b13509910ec4c84f81ee982d345cf6844f9037fe47aa36572d3f9d85ca6ac743fa7055fc61df2d2a35e0c1c0bd26f4682fb3861800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1067a71fccb1f07ccb1cb4f0e75f32f25fbc177b6f0d44f05c72e7ade4c52c6b1b80b7f68ee55cff775eb8246428b40825fd1c91b5f60f2d5750dce552fd58a"} 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1da384930e93a1d9746b13509910ec4c84f81ee982d345cf6844f9037fe47aa36572d3f9d85ca6ac743fa7055fc61df2d2a35e0c1c0bd26f4682fb3861800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1067a71fccb1f07ccb1cb4f0e75f32f25fbc177b6f0d44f05c72e7ade4c52c6b1b80b7f68ee55cff775eb8246428b40825fd1c91b5f60f2d5750dce552fd58a"} 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=1273.195183 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-14 19:25:39.616706) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:39.619955) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1da384930e93a1d9746b13509910ec4c84f81ee982d345cf6844f9037fe47aa36572d3f9d85ca6ac743fa7055fc61df2d2a35e0c1c0bd26f4682fb3861800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1067a71fccb1f07ccb1cb4f0e75f32f25fbc177b6f0d44f05c72e7ade4c52c6b1b80b7f68ee55cff775eb8246428b40825fd1c91b5f60f2d5750dce552fd58a"} 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.011353 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8f1da384930e93a1d9746b13509910ec4c84f81ee982d345cf6844f9037fe47aa36572d3f9d85ca6ac743fa7055fc61df2d2a35e0c1c0bd26f4682fb3861800", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d1067a71fccb1f07ccb1cb4f0e75f32f25fbc177b6f0d44f05c72e7ade4c52c6b1b80b7f68ee55cff775eb8246428b40825fd1c91b5f60f2d5750dce552fd58a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:39.645435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:39.645821) ========= 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=62c568580acbfdaac3eec7be000001dc-1452826227.118629-1459194577 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 19:25:39.728718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 19:25:39.729086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 19:25:39.729427) ========= ========= Total master_lag: 0.21 =========