builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-054 starttime: 1451686349.06 results: success (0) buildid: 20160101113010 builduid: eb89fa5148334fad86be359e60050f79 revision: a5d53deacf63b351328166a0d349b45459804848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.063942) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.064437) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.065126) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006150 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.131272) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.131687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.234549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.234812) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033823 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.285918) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.286199) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.286585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.286880) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-01 14:12:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.1M=0s 2016-01-01 14:12:29 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.270607 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.571281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.571642) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.343957 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.927473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:29.927822) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5d53deacf63b351328166a0d349b45459804848 --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 a5d53deacf63b351328166a0d349b45459804848 --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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-01 14:12:30,039 truncating revision to first 12 chars 2016-01-01 14:12:30,039 Setting DEBUG logging. 2016-01-01 14:12:30,039 attempt 1/10 2016-01-01 14:12:30,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5d53deacf63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-01 14:12:30,298 unpacking tar archive at: fx-team-a5d53deacf63/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:30.480940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:30.481468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:30.495273) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:30.495632) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-01 14:12:30.496069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-01 14:12:30.496419) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:30 INFO - MultiFileLogger online at 20160101 14:12:30 in /builds/slave/test-pgo 14:12:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:12:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:12:30 INFO - {'append_to_log': False, 14:12:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:12:30 INFO - 'blob_upload_branch': 'Fx-Team', 14:12:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:12:30 INFO - 'branch': 'Fx-Team', 14:12:30 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:30 INFO - 'config_files': ('talos/linux_config.py',), 14:12:30 INFO - 'default_actions': ('clobber', 14:12:30 INFO - 'read-buildbot-config', 14:12:30 INFO - 'download-and-extract', 14:12:30 INFO - 'populate-webroot', 14:12:30 INFO - 'create-virtualenv', 14:12:30 INFO - 'install', 14:12:30 INFO - 'run-tests'), 14:12:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:30 INFO - 'download_minidump_stackwalk': True, 14:12:30 INFO - 'download_symbols': 'ondemand', 14:12:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:30 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:30 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:30 INFO - 'installer_path': 'installer.exe', 14:12:30 INFO - 'log_level': 'info', 14:12:30 INFO - 'log_name': 'talos', 14:12:30 INFO - 'log_to_console': True, 14:12:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:30 INFO - 'opt_config_files': (), 14:12:30 INFO - 'pip_index': False, 14:12:30 INFO - 'sps_profile': False, 14:12:30 INFO - 'sps_profile_interval': 0, 14:12:30 INFO - 'suite': 'dromaeojs-e10s', 14:12:30 INFO - 'system_bits': '32', 14:12:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:30 INFO - 'title': 'talos-linux64-ix-054', 14:12:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:30 INFO - 'use_talos_json': True, 14:12:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:12:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:30 INFO - 'work_dir': 'build'} 14:12:30 INFO - ##### 14:12:30 INFO - ##### Running clobber step. 14:12:30 INFO - ##### 14:12:30 INFO - Running pre-action listener: _resource_record_pre_action 14:12:30 INFO - Running main action method: clobber 14:12:30 INFO - rmtree: /builds/slave/test-pgo/build 14:12:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:12:35 INFO - Running post-action listener: _resource_record_post_action 14:12:35 INFO - ##### 14:12:35 INFO - ##### Running read-buildbot-config step. 14:12:35 INFO - ##### 14:12:35 INFO - Running pre-action listener: _resource_record_pre_action 14:12:35 INFO - Running main action method: read_buildbot_config 14:12:35 INFO - Using buildbot properties: 14:12:35 INFO - { 14:12:35 INFO - "project": "", 14:12:35 INFO - "product": "firefox", 14:12:35 INFO - "script_repo_revision": "production", 14:12:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:12:35 INFO - "repository": "", 14:12:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:12:35 INFO - "buildid": "20160101113010", 14:12:35 INFO - "pgo_build": "True", 14:12:35 INFO - "basedir": "/builds/slave/test-pgo", 14:12:35 INFO - "buildnumber": 169, 14:12:35 INFO - "slavename": "talos-linux64-ix-054", 14:12:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:12:35 INFO - "platform": "ubuntu64_hw", 14:12:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:12:35 INFO - "branch": "fx-team", 14:12:35 INFO - "repo_path": "integration/fx-team", 14:12:35 INFO - "revision": "a5d53deacf63b351328166a0d349b45459804848", 14:12:35 INFO - "stage_platform": "linux64-pgo", 14:12:35 INFO - "builduid": "eb89fa5148334fad86be359e60050f79", 14:12:35 INFO - "slavebuilddir": "test" 14:12:35 INFO - } 14:12:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:12:35 INFO - Running post-action listener: _resource_record_post_action 14:12:35 INFO - ##### 14:12:35 INFO - ##### Running download-and-extract step. 14:12:35 INFO - ##### 14:12:35 INFO - Running pre-action listener: _resource_record_pre_action 14:12:35 INFO - Running main action method: download_and_extract 14:12:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:12: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')]} 14:12:35 INFO - https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/test_packages.json 14:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/test_packages.json 14:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:12:37 INFO - Downloaded 1302 bytes. 14:12:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:12:37 INFO - Using the following test package requirements: 14:12:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'jsshell-linux-x86_64.zip'], 14:12:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:37 INFO - https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:39 INFO - Downloaded 23195413 bytes. 14:12:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:12:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:12:40 INFO - Return code: 0 14:12:40 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 14:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:40 INFO - https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:46 INFO - Downloaded 23195413 bytes. 14:12:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:12:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:12:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:12:47 INFO - Return code: 0 14:12: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')]} 14:12:47 INFO - https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:12:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:48 INFO - Downloaded 11132285 bytes. 14:12:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:12:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:12:48 INFO - Return code: 0 14:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:48 INFO - https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:12:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:12:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:12:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cnhh29XjQPmtKUus9LHouw/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 14:12:50 INFO - Downloaded 54945293 bytes. 14:12:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:12:50 INFO - mkdir: /builds/slave/test-pgo/properties 14:12:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:12:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:12:50 INFO - Contents: 14:12:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:12:50 INFO - Running post-action listener: _resource_record_post_action 14:12:50 INFO - Running post-action listener: set_extra_try_arguments 14:12:50 INFO - ##### 14:12:50 INFO - ##### Running populate-webroot step. 14:12:50 INFO - ##### 14:12:50 INFO - Running pre-action listener: _resource_record_pre_action 14:12:50 INFO - Running main action method: populate_webroot 14:12:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:50 INFO - '--tppagecycles', 14:12:50 INFO - '7'], 14:12:50 INFO - 'tests': ['tsvgm']}}, 14:12:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:12:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:12:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:12:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'tests': ['damp', 'tps']}, 14:12:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['damp', 'tps']}, 14:12:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:12:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:50 INFO - 'other': {'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'other_l64': {'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'other_nol64': {'tests': ['a11yr', 14:12:50 INFO - 'ts_paint', 14:12:50 INFO - 'tpaint', 14:12:50 INFO - 'sessionrestore', 14:12:50 INFO - 'sessionrestore_no_auto_restore']}, 14:12:50 INFO - 'svgr': {'tests': ['tsvgx', 14:12:50 INFO - 'tsvgr_opacity', 14:12:50 INFO - 'tart', 14:12:50 INFO - 'tscrollx', 14:12:50 INFO - 'cart']}, 14:12:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['tsvgx', 14:12:50 INFO - 'tsvgr_opacity', 14:12:50 INFO - 'tart', 14:12:50 INFO - 'tscrollx', 14:12:50 INFO - 'cart']}, 14:12:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'tests': ['tp5o']}, 14:12:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'talos_options': ['--e10s'], 14:12:50 INFO - 'tests': ['tp5o']}, 14:12:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'talos_options': ['--xperf_path', 14:12:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:50 INFO - 'tests': ['tp5n']}, 14:12:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:50 INFO - 'talos_options': ['--e10s', 14:12:50 INFO - '--xperf_path', 14:12:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:50 INFO - 'tests': ['tp5n']}}, 14:12:50 INFO - 'talos.zip': {'path': '', 14:12:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:50 INFO - Running post-action listener: _resource_record_post_action 14:12:50 INFO - ##### 14:12:50 INFO - ##### Running create-virtualenv step. 14:12:50 INFO - ##### 14:12:50 INFO - Running pre-action listener: _resource_record_pre_action 14:12:50 INFO - Running main action method: create_virtualenv 14:12:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:12:50 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 14:12:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:12:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:50 INFO - Using real prefix '/usr' 14:12:50 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:12:51 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:53 INFO - Installing pip.................done. 14:12:53 INFO - Return code: 0 14:12:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:53 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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:12:53 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 14:12:53 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 14:12:53 INFO - Using env: {'DISPLAY': ':0', 14:12:53 INFO - 'HOME': '/home/cltbld', 14:12:53 INFO - 'LANG': 'en_US.UTF-8', 14:12:53 INFO - 'LANGUAGE': 'en_US:en', 14:12:53 INFO - 'LOGNAME': 'cltbld', 14:12:53 INFO - 'MAIL': '/var/mail/cltbld', 14:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:53 INFO - 'MOZ_NO_REMOTE': '1', 14:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:53 INFO - 'NO_EM_RESTART': '1', 14:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:53 INFO - 'SHELL': '/bin/bash', 14:12:53 INFO - 'SHLVL': '1', 14:12:53 INFO - 'TERM': 'linux', 14:12:53 INFO - 'TMOUT': '86400', 14:12:53 INFO - 'USER': 'cltbld', 14:12:53 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:53 INFO - '_': '/tools/buildbot/bin/python'} 14:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:53 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 14:12:53 INFO - Cleaning up... 14:12:53 INFO - Return code: 0 14:12:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:53 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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:12:53 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 14:12:53 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 14:12:53 INFO - Using env: {'DISPLAY': ':0', 14:12:53 INFO - 'HOME': '/home/cltbld', 14:12:53 INFO - 'LANG': 'en_US.UTF-8', 14:12:53 INFO - 'LANGUAGE': 'en_US:en', 14:12:53 INFO - 'LOGNAME': 'cltbld', 14:12:53 INFO - 'MAIL': '/var/mail/cltbld', 14:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:53 INFO - 'MOZ_NO_REMOTE': '1', 14:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:53 INFO - 'NO_EM_RESTART': '1', 14:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:53 INFO - 'SHELL': '/bin/bash', 14:12:53 INFO - 'SHLVL': '1', 14:12:53 INFO - 'TERM': 'linux', 14:12:53 INFO - 'TMOUT': '86400', 14:12:53 INFO - 'USER': 'cltbld', 14:12:53 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:53 INFO - '_': '/tools/buildbot/bin/python'} 14:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:53 INFO - Downloading/unpacking psutil>=0.7.1 14:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:12:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:12:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:55 INFO - Installing collected packages: psutil 14:12:55 INFO - Running setup.py install for psutil 14:12:55 INFO - building 'psutil._psutil_linux' extension 14:12:55 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 14:12:56 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 14:12:56 INFO - building 'psutil._psutil_posix' extension 14:12:56 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 14:12:56 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 14:12:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:58 INFO - Successfully installed psutil 14:12:58 INFO - Cleaning up... 14:12:58 INFO - Return code: 0 14:12:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:12:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:12:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:12:58 INFO - Using env: {'DISPLAY': ':0', 14:12:58 INFO - 'HOME': '/home/cltbld', 14:12:58 INFO - 'LANG': 'en_US.UTF-8', 14:12:58 INFO - 'LANGUAGE': 'en_US:en', 14:12:58 INFO - 'LOGNAME': 'cltbld', 14:12:58 INFO - 'MAIL': '/var/mail/cltbld', 14:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:58 INFO - 'MOZ_NO_REMOTE': '1', 14:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:58 INFO - 'NO_EM_RESTART': '1', 14:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:12:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:12:58 INFO - 'SHELL': '/bin/bash', 14:12:58 INFO - 'SHLVL': '1', 14:12:58 INFO - 'TERM': 'linux', 14:12:58 INFO - 'TMOUT': '86400', 14:12:58 INFO - 'USER': 'cltbld', 14:12:58 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:58 INFO - '_': '/tools/buildbot/bin/python'} 14:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:13:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:13:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:13:00 INFO - Installing collected packages: mozsystemmonitor 14:13:00 INFO - Running setup.py install for mozsystemmonitor 14:13:00 INFO - Successfully installed mozsystemmonitor 14:13:00 INFO - Cleaning up... 14:13:00 INFO - Return code: 0 14:13:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:13:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:13:00 INFO - Using env: {'DISPLAY': ':0', 14:13:00 INFO - 'HOME': '/home/cltbld', 14:13:00 INFO - 'LANG': 'en_US.UTF-8', 14:13:00 INFO - 'LANGUAGE': 'en_US:en', 14:13:00 INFO - 'LOGNAME': 'cltbld', 14:13:00 INFO - 'MAIL': '/var/mail/cltbld', 14:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:00 INFO - 'MOZ_NO_REMOTE': '1', 14:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:00 INFO - 'NO_EM_RESTART': '1', 14:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:00 INFO - 'SHELL': '/bin/bash', 14:13:00 INFO - 'SHLVL': '1', 14:13:00 INFO - 'TERM': 'linux', 14:13:00 INFO - 'TMOUT': '86400', 14:13:00 INFO - 'USER': 'cltbld', 14:13:00 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:00 INFO - '_': '/tools/buildbot/bin/python'} 14:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13: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 14:13:02 INFO - Downloading blobuploader-1.2.4.tar.gz 14:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:13:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:13:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:13:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:13:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:02 INFO - Downloading docopt-0.6.1.tar.gz 14:13:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:13:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:13:02 INFO - Installing collected packages: blobuploader, requests, docopt 14:13:02 INFO - Running setup.py install for blobuploader 14:13:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:13:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:13:03 INFO - Running setup.py install for requests 14:13:03 INFO - Running setup.py install for docopt 14:13:03 INFO - Successfully installed blobuploader requests docopt 14:13:03 INFO - Cleaning up... 14:13:03 INFO - Return code: 0 14:13:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:03 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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:03 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 14:13:03 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 14:13:03 INFO - Using env: {'DISPLAY': ':0', 14:13:03 INFO - 'HOME': '/home/cltbld', 14:13:03 INFO - 'LANG': 'en_US.UTF-8', 14:13:03 INFO - 'LANGUAGE': 'en_US:en', 14:13:03 INFO - 'LOGNAME': 'cltbld', 14:13:03 INFO - 'MAIL': '/var/mail/cltbld', 14:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:03 INFO - 'MOZ_NO_REMOTE': '1', 14:13:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:03 INFO - 'NO_EM_RESTART': '1', 14:13:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:03 INFO - 'SHELL': '/bin/bash', 14:13:03 INFO - 'SHLVL': '1', 14:13:03 INFO - 'TERM': 'linux', 14:13:03 INFO - 'TMOUT': '86400', 14:13:03 INFO - 'USER': 'cltbld', 14:13:03 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:03 INFO - '_': '/tools/buildbot/bin/python'} 14:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:13:03 INFO - Running setup.py (path:/tmp/pip-G62WCM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:13:03 INFO - Running setup.py (path:/tmp/pip-Xx79Jq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:13:03 INFO - Running setup.py (path:/tmp/pip-WE36H_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:13:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:13:03 INFO - Running setup.py (path:/tmp/pip-uQxCd8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:13:04 INFO - Running setup.py (path:/tmp/pip-ahznsU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:13:04 INFO - Running setup.py (path:/tmp/pip-DL3T70-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:13:04 INFO - Running setup.py (path:/tmp/pip-_5LaPu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:13:04 INFO - Running setup.py (path:/tmp/pip-wAKrWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:13:04 INFO - Running setup.py (path:/tmp/pip-6pRO4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:13:04 INFO - Running setup.py (path:/tmp/pip-fsXp7K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:13:04 INFO - Running setup.py (path:/tmp/pip-fJNZLF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:13:04 INFO - Running setup.py (path:/tmp/pip-4cU_Rb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:13:04 INFO - Running setup.py (path:/tmp/pip-Ebwhnk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:13:04 INFO - Running setup.py (path:/tmp/pip-IL5JFs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:13:04 INFO - Running setup.py (path:/tmp/pip-B8SjLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:13:04 INFO - Running setup.py (path:/tmp/pip-aW5ZhP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:13:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:13:04 INFO - Running setup.py (path:/tmp/pip-ZnwRS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:13:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:13:04 INFO - Running setup.py install for manifestparser 14:13:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for mozcrash 14:13:05 INFO - Running setup.py install for mozdebug 14:13:05 INFO - Running setup.py install for mozdevice 14:13:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for mozfile 14:13:05 INFO - Running setup.py install for mozhttpd 14:13:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for mozinfo 14:13:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for mozInstall 14:13:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for mozleak 14:13:05 INFO - Running setup.py install for mozlog 14:13:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:13:05 INFO - Running setup.py install for moznetwork 14:13:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Running setup.py install for mozprocess 14:13:06 INFO - Running setup.py install for mozprofile 14:13:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Running setup.py install for mozrunner 14:13:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Running setup.py install for mozscreenshot 14:13:06 INFO - Running setup.py install for moztest 14:13:06 INFO - Running setup.py install for mozversion 14:13:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:13:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:13:06 INFO - Cleaning up... 14:13:06 INFO - Return code: 0 14:13:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:06 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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:06 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 14:13:06 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 14:13:06 INFO - Using env: {'DISPLAY': ':0', 14:13:06 INFO - 'HOME': '/home/cltbld', 14:13:06 INFO - 'LANG': 'en_US.UTF-8', 14:13:06 INFO - 'LANGUAGE': 'en_US:en', 14:13:06 INFO - 'LOGNAME': 'cltbld', 14:13:06 INFO - 'MAIL': '/var/mail/cltbld', 14:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:06 INFO - 'MOZ_NO_REMOTE': '1', 14:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:06 INFO - 'NO_EM_RESTART': '1', 14:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:06 INFO - 'SHELL': '/bin/bash', 14:13:06 INFO - 'SHLVL': '1', 14:13:06 INFO - 'TERM': 'linux', 14:13:06 INFO - 'TMOUT': '86400', 14:13:06 INFO - 'USER': 'cltbld', 14:13:06 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:06 INFO - '_': '/tools/buildbot/bin/python'} 14:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:13:06 INFO - Running setup.py (path:/tmp/pip-keIGN5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:13:07 INFO - Running setup.py (path:/tmp/pip-cu2vYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:13:07 INFO - Running setup.py (path:/tmp/pip-j4jUjZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:13:07 INFO - Running setup.py (path:/tmp/pip-_DjeMG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:13:07 INFO - Running setup.py (path:/tmp/pip-i0jDjh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:13:07 INFO - Running setup.py (path:/tmp/pip-ByiaHr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:13:07 INFO - Running setup.py (path:/tmp/pip-caSTAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:13:07 INFO - Running setup.py (path:/tmp/pip-_9pT09-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:13:07 INFO - Running setup.py (path:/tmp/pip-3dTEvr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:13:07 INFO - Running setup.py (path:/tmp/pip-5ZyNcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:13:07 INFO - Running setup.py (path:/tmp/pip-hlvMz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:13:07 INFO - Running setup.py (path:/tmp/pip-4IMqq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:13:07 INFO - Running setup.py (path:/tmp/pip-QSD4kb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:13:07 INFO - Running setup.py (path:/tmp/pip-inXnke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:13:07 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)) 14:13:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:13:07 INFO - Running setup.py (path:/tmp/pip-uVyjqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:13:08 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)) 14:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:13:08 INFO - Running setup.py (path:/tmp/pip-VbuEKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:13:08 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)) 14:13:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:13:08 INFO - Running setup.py (path:/tmp/pip-L7opNA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:13:08 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)) 14:13:08 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)) 14:13:08 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)) 14:13:08 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)) 14:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:13:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:08 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 14:13:09 INFO - Downloading blessings-1.5.1.tar.gz 14:13:09 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 14:13:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:13:09 INFO - Installing collected packages: blessings 14:13:09 INFO - Running setup.py install for blessings 14:13:10 INFO - Successfully installed blessings 14:13:10 INFO - Cleaning up... 14:13:10 INFO - Return code: 0 14:13:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:13:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:13:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:13:10 INFO - Reading from file tmpfile_stdout 14:13:10 INFO - Current package versions: 14:13:10 INFO - argparse == 1.2.1 14:13:10 INFO - blessings == 1.5.1 14:13:10 INFO - blobuploader == 1.2.4 14:13:10 INFO - docopt == 0.6.1 14:13:10 INFO - manifestparser == 1.1 14:13:10 INFO - mozInstall == 1.12 14:13:10 INFO - mozcrash == 0.16 14:13:10 INFO - mozdebug == 0.1 14:13:10 INFO - mozdevice == 0.47 14:13:10 INFO - mozfile == 1.2 14:13:10 INFO - mozhttpd == 0.7 14:13:10 INFO - mozinfo == 0.9 14:13:10 INFO - mozleak == 0.1 14:13:10 INFO - mozlog == 3.1 14:13:10 INFO - moznetwork == 0.27 14:13:10 INFO - mozprocess == 0.22 14:13:10 INFO - mozprofile == 0.28 14:13:10 INFO - mozrunner == 6.11 14:13:10 INFO - mozscreenshot == 0.1 14:13:10 INFO - mozsystemmonitor == 0.0 14:13:10 INFO - moztest == 0.7 14:13:10 INFO - mozversion == 1.4 14:13:10 INFO - psutil == 3.1.1 14:13:10 INFO - requests == 1.2.3 14:13:10 INFO - wsgiref == 0.1.2 14:13:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 14:13:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 14:13:10 INFO - Using env: {'DISPLAY': ':0', 14:13:10 INFO - 'HOME': '/home/cltbld', 14:13:10 INFO - 'LANG': 'en_US.UTF-8', 14:13:10 INFO - 'LANGUAGE': 'en_US:en', 14:13:10 INFO - 'LOGNAME': 'cltbld', 14:13:10 INFO - 'MAIL': '/var/mail/cltbld', 14:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:10 INFO - 'MOZ_NO_REMOTE': '1', 14:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:10 INFO - 'NO_EM_RESTART': '1', 14:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:10 INFO - 'SHELL': '/bin/bash', 14:13:10 INFO - 'SHLVL': '1', 14:13:10 INFO - 'TERM': 'linux', 14:13:10 INFO - 'TMOUT': '86400', 14:13:10 INFO - 'USER': 'cltbld', 14:13:10 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:10 INFO - '_': '/tools/buildbot/bin/python'} 14:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 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)) 14:13:10 INFO - Cleaning up... 14:13:10 INFO - Return code: 0 14:13:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:10 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 14:13:10 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 14:13:10 INFO - Using env: {'DISPLAY': ':0', 14:13:10 INFO - 'HOME': '/home/cltbld', 14:13:10 INFO - 'LANG': 'en_US.UTF-8', 14:13:10 INFO - 'LANGUAGE': 'en_US:en', 14:13:10 INFO - 'LOGNAME': 'cltbld', 14:13:10 INFO - 'MAIL': '/var/mail/cltbld', 14:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:10 INFO - 'MOZ_NO_REMOTE': '1', 14:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:10 INFO - 'NO_EM_RESTART': '1', 14:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:10 INFO - 'SHELL': '/bin/bash', 14:13:10 INFO - 'SHLVL': '1', 14:13:10 INFO - 'TERM': 'linux', 14:13:10 INFO - 'TMOUT': '86400', 14:13:10 INFO - 'USER': 'cltbld', 14:13:10 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:10 INFO - '_': '/tools/buildbot/bin/python'} 14:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:10 INFO - Downloading/unpacking jsonschema 14:13:10 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 14:13:10 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 14:13:10 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 14:13:10 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 14:13:10 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 14:13:10 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 14:13:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:13:12 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 14:13:12 INFO - Downloading/unpacking functools32 (from jsonschema) 14:13:12 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 14:13:12 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 14:13:12 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 14:13:12 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 14:13:12 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 14:13:12 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 14:13:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:13:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:13:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:13:12 INFO - warning: no files found matching '*.txt' 14:13:12 INFO - no previously-included directories found matching 'build' 14:13:12 INFO - no previously-included directories found matching 'dist' 14:13:12 INFO - no previously-included directories found matching '.git*' 14:13:12 INFO - Installing collected packages: jsonschema, functools32 14:13:12 INFO - Running setup.py install for functools32 14:13:12 INFO - warning: no files found matching '*.txt' 14:13:12 INFO - no previously-included directories found matching 'build' 14:13:12 INFO - no previously-included directories found matching 'dist' 14:13:12 INFO - no previously-included directories found matching '.git*' 14:13:12 INFO - Successfully installed jsonschema functools32 14:13:12 INFO - Cleaning up... 14:13:12 INFO - Return code: 0 14:13:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:13:12 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')]} 14:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:12 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')]} 14:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:13:12 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 0x7f840d9bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e52630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, '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': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', '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 14:13:12 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 14:13:12 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 14:13:12 INFO - Using env: {'DISPLAY': ':0', 14:13:12 INFO - 'HOME': '/home/cltbld', 14:13:12 INFO - 'LANG': 'en_US.UTF-8', 14:13:12 INFO - 'LANGUAGE': 'en_US:en', 14:13:12 INFO - 'LOGNAME': 'cltbld', 14:13:12 INFO - 'MAIL': '/var/mail/cltbld', 14:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:12 INFO - 'MOZ_NO_REMOTE': '1', 14:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:12 INFO - 'NO_EM_RESTART': '1', 14:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:12 INFO - 'SHELL': '/bin/bash', 14:13:12 INFO - 'SHLVL': '1', 14:13:12 INFO - 'TERM': 'linux', 14:13:12 INFO - 'TMOUT': '86400', 14:13:12 INFO - 'USER': 'cltbld', 14:13:12 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:12 INFO - '_': '/tools/buildbot/bin/python'} 14:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:13:13 INFO - Downloading/unpacking flake8 14:13:13 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 14:13:13 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 14:13:13 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 14:13:13 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 14:13:13 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 14:13:13 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 14:13:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:13:14 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 14:13:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:13:15 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 14:13:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:15 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 14:13:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:13:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:13:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:15 INFO - no previously-included directories found matching 'docs/_build' 14:13:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:13:15 INFO - Running setup.py install for pep8 14:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:13:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:13:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:13:15 INFO - no previously-included directories found matching 'docs/_build' 14:13:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:13:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:13:15 INFO - Cleaning up... 14:13:15 INFO - Return code: 0 14:13:15 INFO - Running post-action listener: _resource_record_post_action 14:13:15 INFO - Running post-action listener: _start_resource_monitoring 14:13:15 INFO - Starting resource monitoring. 14:13:15 INFO - ##### 14:13:15 INFO - ##### Running install step. 14:13:15 INFO - ##### 14:13:15 INFO - Running pre-action listener: _resource_record_pre_action 14:13:15 INFO - Running main action method: install 14:13:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:13:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:13:15 INFO - Reading from file tmpfile_stdout 14:13:15 INFO - Detecting whether we're running mozinstall >=1.0... 14:13:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:13:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:13:16 INFO - Reading from file tmpfile_stdout 14:13:16 INFO - Output received: 14:13:16 INFO - Usage: mozinstall [options] installer 14:13:16 INFO - Options: 14:13:16 INFO - -h, --help show this help message and exit 14:13:16 INFO - -d DEST, --destination=DEST 14:13:16 INFO - Directory to install application into. [default: 14:13:16 INFO - "/builds/slave/test-pgo"] 14:13:16 INFO - --app=APP Application being installed. [default: firefox] 14:13:16 INFO - mkdir: /builds/slave/test-pgo/build/application 14:13:16 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'] 14:13:16 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 14:13:31 INFO - Reading from file tmpfile_stdout 14:13:31 INFO - Output received: 14:13:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:13:31 INFO - Running post-action listener: _resource_record_post_action 14:13:31 INFO - ##### 14:13:31 INFO - ##### Running run-tests step. 14:13:31 INFO - ##### 14:13:31 INFO - Running pre-action listener: _resource_record_pre_action 14:13:31 INFO - Running main action method: run_tests 14:13:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:13:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:13:31 INFO - Python 2.7.3 14:13:31 INFO - Return code: 0 14:13:31 INFO - grabbing minidump binary from tooltool 14:13:31 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')]} 14:13:31 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 0x1ee3840>, '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 0x1e506b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e50b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:13:31 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 14:13:31 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 14:13:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:31 INFO - Return code: 0 14:13:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:13:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:13:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:13:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:13:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:13:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:13:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:13:32 INFO - Return code: 0 14:13:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 14:13:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:13:32 INFO - Using env: {'DISPLAY': ':0', 14:13:32 INFO - 'HOME': '/home/cltbld', 14:13:32 INFO - 'LANG': 'en_US.UTF-8', 14:13:32 INFO - 'LANGUAGE': 'en_US:en', 14:13:32 INFO - 'LOGNAME': 'cltbld', 14:13:32 INFO - 'MAIL': '/var/mail/cltbld', 14:13:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:13:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:32 INFO - 'MOZ_NO_REMOTE': '1', 14:13:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:32 INFO - 'NO_EM_RESTART': '1', 14:13:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:13:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:13:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:13:32 INFO - 'SHELL': '/bin/bash', 14:13:32 INFO - 'SHLVL': '1', 14:13:32 INFO - 'TERM': 'linux', 14:13:32 INFO - 'TMOUT': '86400', 14:13:32 INFO - 'USER': 'cltbld', 14:13:32 INFO - 'XDG_SESSION_COOKIE': '752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366', 14:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:32 INFO - '_': '/tools/buildbot/bin/python'} 14:13:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:13:33 INFO - mozversion application_buildid: 20160101113010 14:13:33 INFO - mozversion application_changeset: a5d53deacf63b351328166a0d349b45459804848 14:13:33 INFO - mozversion application_display_name: Nightly 14:13:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:33 INFO - mozversion application_name: Firefox 14:13:33 INFO - mozversion application_remotingname: firefox 14:13:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:13:33 INFO - mozversion application_vendor: Mozilla 14:13:33 INFO - mozversion application_version: 46.0a1 14:13:33 INFO - mozversion platform_buildid: 20160101113010 14:13:33 INFO - mozversion platform_changeset: a5d53deacf63b351328166a0d349b45459804848 14:13:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:13:33 INFO - mozversion platform_version: 46.0a1 14:13:33 INFO - using testdate: 1451686413 14:13:33 INFO - actual date: 1451686413 14:13:33 INFO - starting webserver on 'localhost:37259' 14:13:33 INFO - SUITE-START | Running 3 tests 14:13:33 INFO - TEST-START | dromaeo_css 14:13:33 INFO - operating with platform_type : linux_ 14:13:33 INFO - Initialising browser for dromaeo_css test... 14:13:33 INFO - TEST-INFO | started process 3317 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzQjuT0/profile http://localhost:37259/getInfo.html) 14:13:41 INFO - PROCESS | 3317 | __metrics Screen width/height:1600/1200 14:13:41 INFO - PROCESS | 3317 | colorDepth:24 14:13:41 INFO - PROCESS | 3317 | Browser inner width/height: 1024/697 14:13:41 INFO - PROCESS | 3317 | __metrics 14:13:41 INFO - PROCESS | 3317 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:13:42 INFO - TEST-INFO | 3317: exit 0 14:13:42 INFO - Browser initialized. 14:13:42 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:42 INFO - TEST-INFO | started process 3450 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzQjuT0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:54 INFO - PROCESS | 3450 | RSS: Main: 150929408 14:13:54 INFO - PROCESS | 3450 | 14:14:43 INFO - PROCESS | 3450 | 1451686483816 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] 14:16:53 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37259/tests/dromaeo/cssquery-ext.html) 14:16:55 INFO - PROCESS | 3450 | RSS: Main: 153874432 14:16:55 INFO - PROCESS | 3450 | 14:19:57 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-ext.html (next: http://localhost:37259/tests/dromaeo/cssquery-jquery.html) 14:19:57 INFO - PROCESS | 3450 | RSS: Main: 152756224 14:19:57 INFO - PROCESS | 3450 | 14:22:59 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37259/tests/dromaeo/cssquery-mootools.html) 14:22:59 INFO - PROCESS | 3450 | RSS: Main: 153108480 14:22:59 INFO - PROCESS | 3450 | 14:26:01 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37259/tests/dromaeo/cssquery-prototype.html) 14:26:02 INFO - PROCESS | 3450 | RSS: Main: 152002560 14:26:02 INFO - PROCESS | 3450 | 14:29:04 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37259/tests/dromaeo/cssquery-yui.html) 14:29:05 INFO - PROCESS | 3450 | RSS: Main: 152948736 14:29:05 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:37259/tests/dromaeo/cssquery-yui.html (next: http://localhost:37259/tests/dromaeo/cssquery-dojo.html) 14:32:07 INFO - PROCESS | 3450 | RSS: Main: 155623424 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | __start_tp_report 14:32:07 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 14:32:07 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 14:32:07 INFO - PROCESS | 3450 | |i|pagename|runs| 14:32:07 INFO - PROCESS | 3450 | |0;dojo.html;3132.7493800495963;3174.380995705837;3206.134343727192;3221.8550165242564;3223.129754966159;5112.744362781856;5323.121684921988;5342.786288548458;5361.088614935461;5362.839114826552;5278.261043453919;5300.09898317286;5376.91934620981;5404.081306177949;5413.675179489233;4902.60779137669;4904.852854414374;4931.753412329387;5001;5006;4880.633952453562;4913.238448040559;4932.383452068491;5008.073506401309;5041.395032596093;4613.308003799423;4713;4857.319975203474;4862.975685121552;4931.65478416511;4865.464798872121;4872.293517439952;4924.827631032933;4926.8768280793265;4955.702657840505;4762;4864.391951006124;4880.463149053601;4909.901801963976;4956.950430495721;5168.61235407346;5189.974050129763;5204.219367094928;5208.088584497697;5285.894282114375;5779.422057794229;5783.913241301384;5797.942020579824;5799.82600521985;5813.09896965971;5697.401772813878;5839.416058394169;5845.298564172284;5849.356570777211;5877.764889404461;5316.362036555638;5387.757550910218;5432.266644003049;5433.918491222635;5449.6730196188355;5790.71046447676;5818.0981947798155;5882.058870580687;5883.17635531026;5884;5666.206731057655;5681.57388195887;5712.371639119693;5721.8569535761935;5728.112142617818;5784.132380142928;5793.826185214451;5842.357340692521;5903.0555111182;5933.495652869555;5669.461401166965;5686.2607860977805;5687.9431205687415;5689.260396148474;5710.514606258432;5603.915941260884;5697.9430205698245;5725.2843394575675;5725.742341594639;5794.130880367894;4416.6025057744955;4458.130664520452;4480.663950203748;4510;4518.322251662211;3929.7838618876235;3981.343078392033;3989.3816458448987;3994.5206575210577;4025.879223623296;5231.764570594332;5306.8938621228135;5328.36059672834;5402.216678581583;5462.781488740486;5818.505427038749;5848.853778655568;5861.443162899518;5867.882642347129;5881.382454842265;5405;5405.918911216335;5407.405185429599;5408.513233808976;5444.863878402993;4754.21555443348;4978.800847966041;4985.077760614298;4997.200447928314;5093.18509038552;5834.0373838317055;5834.066549352084;5913.467787899023;5944.3164036136395;5959.255093113361;5777.104548794776;5786.392428794916;5793.594448388572;5832.533397328289;5839.124131380327;5840.386759390203;5920.644761314335;5979.880402392015;5982.730777115127;5998.88002239944;5583.944160558505;5626.85932851682;5629.408912064175;5634.32388113429;5637.182608521824;5689.971550142222;5743.282089738783;5769.567282453749;5916.3492015877355;5920.467157955804;5707.1153971134545;5742.397048309867;5742.5118864895285;5746.511546518593;5747.913781293368;5672.234248376416;5684.516816070681;5734.455226753618;5735.827925162252;5752.223449834219;5386.8956863843605;5510.0632892409185;5537.335519737658;5579.3304803422225;5636.549076073986;5617.775288988395;5667.716614169358;5681.630694004876;5684.77260909559;5686.175504551899;5413.431589683027;5520.282363292747;5584.078627026495;5611.5230205433;5611.943880561143 14:32:07 INFO - PROCESS | 3450 | |1;ext.html;524.6327570700511;533.3732863884935;540.5648452995338;559.44614831317;612.3845535237086;34641;35218.11954701134;35364.11589710255;35474.46788298171;35479.2904141917;38172.80913595428;38641.61358386415;38747.22505549887;38856.22287554247;38866.41700374489;8260.050094239165;8485.193906578865;8509.829803403929;8518.27594654455;8574.828503429928;8378.916210837875;8487.278581320596;8487.278581320596;8488.278496327788;8493.853329800491;8561;8671.262942649882;8716.738497845075;8721.12788721126;8806.427582207136;8590.269827064707;8629.827403451958;8659.393842431033;8781.165789250012;8800.735977920673;8666.696665616673;8736.170063843925;8758.036615972238;8762.780930476725;8780.956095219546;38489.230215395815;39059.60940390588;39235.41146882799;39287.60712392868;39348;2750.8349499030123;3030.1364111228195;3050.6186726659166;3075.1850759548515;3121.391328690906;27053.1884043479;28015.439691206062;28670.13989580295;28751.56872646912;29240.56139157893;3643.125649844045;3669.2478042001326;3752.212035472554;3835.5780864104927;3867.57456679765;214743;215474;215522.99999999843;215652;216649;50198.498015020115;51118.48881511212;52015.47984520182;53201.46798531965;56015.43984560184;50893.74553127285;51369.486305137216;51377.48622513802;51611.741941290056;51625.741871290404;14686.779698304534;14992.400303987937;15014.324355404033;15066.54800355991;15071.4724984625;11482.0814334853;11502.424878756028;11523.942380288212;11550.59572914944;11588.710282243012;18087.366942157223;18127.731058825757;18985.525361866064;19051.428457146307;19093.71359429582;7288.234735352712;7532;7534.736284230025;7556.546607203585;7618.314351708373;896.6771962093641;973.7030205787162;1040.661784919889;1062.7396287909512;1074.6722249713912;24393.14623988152;24744.752552474605;24930;24956.376090597518;26258;989.4557993103908;1025.4206373399006;1079.7030816525519;1115.0522056252282;1157.5427706056062;15102.244887755569;15520.456784012731;15949.362025518849;16054.678906421806;16093.839061609468;324092;327063.6468176629;327239;327662;328115;51454.48545514497;52488.47511524836;52802.471975280525;52905;52968.73515632474;1286.4275397448046;1342.5905098944916;1346.07121086452;1356.1117468058635;1356.5998030581002;28251.57622635621;28992.275193120342;29134.854325728236;29258.268543286587;29518.852405737834;45272.54727452815;45680.31479527876;46248.76875615735;46268.07463850637;46344;282580;282834;283611;287908;290166;29830.70169298279;30818.53772193374;31006.53490197694;31223.219419514695;31269.84365078251;36439.453408198366;36898.26203475969;37282;37368.25263494769;37695;31719.841400792848;31818.68181318157;31848.36303273968;32392.676073238967;32819.34361312808;32370.514442282914;32427;34059.82970085134;34623.4806477898;35837;33353;33618.663813361556;34151.4877276846;34270.314593708485;34665.306693866485;29702;30799.846000769852;31939.201519962186;32132.518012230303;32135.51796723098;24504.38739031467;24607.38481537976;24692.13577524778;24727.25818225456;24944.625830612917 14:32:07 INFO - PROCESS | 3450 | |2;jquery.html;321.53056537455313;323.8753080064175;331.6236072058216;331.8125259228536;332.94339962206425;11313.943430282838;11753.588624398148;16158.83841161588;16752.581185470368;16896.662066758672;17376.131193440342;17456.912715436403;17572.121393930283;17944.55138621535;18020.909895450506;5952.494038006764;6114.296855861566;6135.049067394539;6141.232345956755;6150.1697270868535;4897.4123105227245;6045.123457098718;6075.088736689488;6077.149199112106;6080.452759251666;5939.703014849262;6038.124471951564;6047.092936059582;6101.603395779282;6123.326434092269;5966.582339236255;5982.521398288149;6228.564000519988;6442.93557064428;6443.226812782496;5913.497352725023;6206.193194884681;6227.844303892393;6445.709943052574;6463.57986730861;22008.779912200833;22315.665265021038;23118.306450806336;23146.884265578563;23172.42068948273;2125.4792575819024;2150.193677370986;2218.811401030914;2230.241717815934;2233.3300009996938;10328.328658637165;14179.29103544829;14208.502702405367;14325.140491570539;14388.136711797326;1869.3457289948544;1895.8293753562107;1953.6092781443626;1990.7611086669692;2070.3271436782957;65143.3485665142;65233;67674;71050.64474677645;71083;15079.321430535652;15110.244487775568;15264.465743698916;15308;15385.615359615875;12745.171563848506;13071.41178646963;13086.08397412191;24018;24105.276841694777;7259.382952449101;7389.66746496409;7537.660805263777;7614.428917831185;7652.885206721904;7310.342069213796;7347.742829000959;7355.154157271875;7398.03825502692;7405.481616286916;4513.277875539898;4539.909201815945;4546.727196368229;4558.772061396917;4575.633949284049;1806.719958406449;1844.7601811764653;1847.78750443698;1849.2972670385168;1865.720141978714;927.2535608834818;994.7165057958592;1019.0624625344701;1019.8521214423866;1046.26238501856;16465.423710170326;16786.664266714597;16843.578910527336;17158.227879745442;17408.21663025167;885.6014793343021;911.7082533589321;935.9391639543408;943.2831048403262;944.6929747831982;8870.600822962982;9189.678361257324;9236;9305.813883722423;9371.671991480402;498560;500384;556569;606282;614157;39429.2114157721;80702.59648701837;83014.50956471315;84327.5783621078;84687.57656211803;1171.37916904041;1172.976540469186;1186.8397766301612;1200.6578125234266;1213.7754515414676;14266.144031358152;14469.204193769443;14473.276336182938;14559.27203639835;14666.193359365338;30448.84775576108;31608.525872112397;32526.186845329055;32532.83733581317;34322.313553729284;44641;45269.54730452785;45394;46223.53776462192;48777.5122248773;9410.153086222273;9514.762130946781;9725.85411218818;9852.605895764089;9859.457729824928;17401.564960875574;17644.206010729806;17807.287708491516;17829.10854457298;17960.820391795914;14403.135811851322;14483.203423811792;14744.410223590936;14849.851501485278;14987.17570533631;14355;14507.564773056825;14820.40718371253;14932.7760083601;15108.244587770349;15163.166025868242;15237.161956092077;15584.376624935328;15798.052116872565;15903.204839758197;9581.616735330788;9583.616655333708;9591.952040239754;9649.469279189712;9822.459764712723;10294.919033501374;11918.52325906954;14642.487512936996;14866;14970.47603333878 14:32:07 INFO - PROCESS | 3450 | |3;mootools.html;1418.3405415663672;1431.4274290283886;1568.6862627474509;1752.2465339903836;1760.3134777436794;7213.675384607692;7379.262073792618;7384.150822655396;7393.445491588139;7424.034875466182;7357.448191385641;7384.929185268133;7445.404367650575;7474.738384156555;7478.177400485943;2082.7084208210863;2116.7459904811367;2119.3747844385866;2121.1621409543222;2127.6383014887506;2208.536207396449;2208.933731988043;2215.7562668106493;2221.133757834446;2231.9218827341047;2004.5589970206531;2016.5664382157834;2152.5694861027855;2221.1892659179366;2234.910603575855;2221.1226565506536;2247.494313779395;2277.908883644652;2282.611955967473;2292.495650956787;2250.2799104286637;2283.3378320287097;2288.4622113803243;2288.9356449251013;2295.162265772981;7391.963040184818;7405.1854296027395;7407.481476296662;7478.4391170661875;7485.775426737152;4551.908961820745;4615.076984603093;4615.353850460938;4623.722576645412;4640.79116439761;2981.4782413077623;3000.159955212522;3033.0597514770493;3057.3885222955496;3137.325475022881;924.3390975452584;925.2181906289175;959.7552624080814;961.927855410847;981.5239608789731;10065.798684026278;10073.143782778472;10097.899021009769;10125.594976200942;10136.239782016379;3995.1210733639136;4050.0684842485803;4066.0851308455362;4107.589241075928;4146.108586653884;8268.793280168044;8323.875141872877;8388.622511986976;8409.453385529921;8422.915770842335;4453.421055262795;4466.3523789050405;4474.373587697725;4478.350639157304;4500.437445319335;4075.7758323292505;4080.6939479539155;4094.549599544048;4134.73124246923;4139.503259608866;3253.2680146966745;3265.7877237979455;3288.358770039867;3309.1561651778643;3316.8507417166284;991.4794732765212;1010.4695035106481;1011.1657882247175;1011.544804837826;1013.45780007697;1022.5807418958192;1023.22746326523;1067.957281708723;1142.782871254459;1288.3429450980068;6849.1780986281965;6891.448684105259;6901.102856628606;6907.240203577602;6921.757738479129;1166.5975238542858;1172.3317708905843;1175.8647755508225;1200.9855263289207;1226.993865030687;5154.407243167008;5222.164453687392;5235.3717553893775;5241.842744717665;5255.185446255837;8241.876371854427;8700.608472618747;8718.651253949898;8724.302055835518;8741.694040708544;8502.234798868009;8535;8603.09667484905;8690.130986901258;8712.912870871336;6723.55443579623;6767.323267673193;6958.478114141359;6960.129983752031;7131.465140114512;6706.631135287411;6739.5619284746335;6768.323167683192;6780.423663988616;6782.796516104525;7452.292032256927;7795.415343849348;7870.134285228734;7883.251091146332;7914.525128492079;7841.451098423056;8170.959145204236;8208.958955205186;8209.138040505899;8322.70870519529;6239.844003899939;6243.906341404973;6418.550701450854;6459.967700161469;6462.676866156579;7235.3488186063505;7286.708531658886;7292.671829767779;7300.780976570712;7310.744123955636;6835.111435513351;6857.657117144023;6918.7232510699005;6924.653767311514;6986.755463558751;5607.186957891165;5652.802151924663;6492.383223593751;6674.9332506676255;6790.660466976533;6735.922252439586;6757;6772.221194562689;6811.114555107804;6817;6104.481119104926;6162.26052873658;6163.7842675506145;6185.319614842274;6245.219347581552;6136;6290.748370065146;6299.622022678654;6304.306526282014;6311.779087731908 14:32:07 INFO - PROCESS | 3450 | |4;prototype.html;309.23464425546774;321.7136748294018;324.81647868954025;327.3420424945858;332.4630721384964;6222.284437289707;6244.687765611712;6285.5914365566205;6317.747290108396;6387.872242555146;6214.285357183925;6239.095331176976;6257.311695713479;6260.718267677954;6263.091851681504;4561.407017087774;4653.1856925038155;4676.111538807616;4729.9054018919605;4731.148393289207;4610.838620648278;4629.375034370368;4629.884252893671;4647.721136731807;4658.976705116486;4577.588017078462;4589.5410458954175;4595.793189306489;4615.238485649864;4646.53534646536;4617.07658468306;4624.306354046887;4629.768511574408;4649.279361698942;4654.999999999983;3895.961040389588;3924.6860251180124;4015.0966032642714;4020.2361551305157;4020.3768415895584;5865.530757539429;5884.705764711747;5910.586258961875;5927.911081333784;5937.228160339128;5417.783288668488;5420.83737487876;5424.511793938565;5432.70120143392;5443.8094666686875;6588.110605068302;6609.405153536205;6610.338966103399;6620.238672552622;6638.435732962704;4253.213155566199;4350.956490435118;4392.648588112943;4419.602235798793;4420.801063952098;6852.5203235773515;6918.342757438036;6927.064846245743;6930.9157424945915;6938.618375989318;4546.52261512543;4549.7497637629585;4574.794134263966;4576.450825900846;4601.723896566216;4430.645548356124;4633.4671512775785;4637.628989680885;4640.628749700016;4641.907161856744;5378.462153784669;5392.757325920343;5404.432534583812;5408.675479471166;5427.782888684487;6631.607362453842;6651.201855777338;6664;6688.966555167193;6753.527253092237;1627.6337823989745;1632.583691158747;1641.2040160522138;1643.4658735910878;1644.9506514804336;1036.9896301037045;1053.4732633683159;1073.8281874899978;1073.838924161382;1076.9299995500423;6113.510919126459;6189.6286222826775;6224.502039836802;6251.562390632612;6268.435840774352;6830.556013859084;6888.173419189629;6899.965500172568;6910.723571057101;6929.445644348541;6047.697615119227;6125.754969801247;6149.077638354193;6160.168377269101;6166.044263139221;3678.2459595782802;3734.2158146788934;3739.457778622085;3742.7567208131386;3743.0642339415144;6817.761378351734;6963.721451141999;6980.476464265201;7129.750458733919;7142.178649455275;7063.364297213276;7104.644767761694;7112.893306600405;7174.354308112191;7212.242714515005;6962.1645402551;7041.401480874183;7044;7061.717531298793;7068.399186069241;6944.4444444445335;6944.583325000516;6946.097007389007;6946.305369463215;6981.371676549135;6880.759173428906;6883.586984780929;6892.241853396022;6906.963955406729;6923.757668481579;6877.828054298482;7057.576545407292;7061.964690176722;7077.504574679723;7098.325659062587;4459.643228541774;4533.478649955166;4547.613452856412;4547.840825571089;4561.703489273186;6986.196587392312;6993.790186294419;6996.580205187705;7002.264762199896;7010;6579.671016449254;6718.798436046926;6719.865602688016;6820.215675197416;6827.078344423439;6664.4668426524795;6699.598024118569;6754.797356079325;6769.830754231184;6785.626790526371;6671.899921501278;6682.799516014527;6683.498737594603;6690.19717633887;6691.263960964193;6731.764388246388;6826.873565861776;6835.316468353125;6840;6847.554908930903;6654.035164901159;6654.101696271135;6656.101426307387;6658.933410665832;6659.034440006075 14:32:07 INFO - PROCESS | 3450 | |5;yui.html;704.2534912992229;733.7431898835407;781.5818537082662;790.9841803163933;817.4727300890924;13270.734585308288;13305.800412993789;13460.865391346084;13550.390232439539;13581.3209339533;12611.747765044694;12710.745785084293;12732.108752387336;12742.80885786714;12750.10749247553;666.580054565623;673.2358772792891;813.2802469814197;827.5200383777425;838.6351936907434;821.7000794709918;830.219593582034;831.9417640765149;832.367400775409;833.0794472108294;856;859.7119964811795;862.3015357560365;870.7126648206076;872.9742552500818;847.174005344787;851.1701091435863;858.2233079063426;859.8624220124781;866.9219770220648;639.8944174211249;642.4410762636536;642.7653906324205;644.7227692092398;646.2406672160193;13253.46986120554;13358.933205333911;13508.729825403536;13549.796753048613;13606.319684015858;11509.827352589718;12349.382530873421;12453.501859925593;12656;12845.67885802853;9705.466199359033;9966.053224943618;9991.300608957376;10305.74235644115;10393.075946710378;3554.1647712787476;3588.3540962626716;3618.113562177257;3644.325799727059;3727.5340582427198;40892.59107408918;41124.177516449505;41438.79280603577;41462.9999999997;41494.37758433626;9440.858387124199;9636.807263854684;9650.08324209199;9668.274879384075;9925.404475731479;16685;17087.31650733957;17186.140692965302;17196;17240.65518689644;6859.382655560924;6973.372396484341;6997.335253150943;7087.433005359559;7127.322904324081;3742.5134732484603;3836.0026393137427;3858.9421158682644;3900.551436584772;3928.017995501125;2906.5640153977074;2959.2749776304513;2973.2864112612815;2994.5508173773674;3006.3536339686634;531.2933798048663;537.052103038138;542.0892899928159;546.5572885962383;552.1414200917532;619.8357435279654;657.523295610688;677.7051982387677;680.8706345794283;692.6848284030754;8042.235987581171;8201.71294004707;8313.45962512447;9252.814943701223;9618.547270446132;543.1743749500737;629.4484096701652;684.565301033847;686.2417029182781;699.0702365853402;4029.274730548471;4084.1831633673382;4089.0041216607397;4231.4742599391375;4234.195502854509;51283.7435812826;51996.48003519992;52506;53266;53322.20016699753;45916.54083459123;46598;46838;47756.76121619439;48093.03813923772;41700;42067.7896610515;42505.787471062446;42731.786341068095;43369;7820.335271501986;7976.282134607914;8270.421070525006;8445.324374049938;8453.95773021131;31842.363152737278;32693.509597355584;33123.171920701214;33526.83236583899;33817;41646.1670766589;42515;42752;43112.78443607762;44774.3283850736;10765.3540787553;11147.55409783632;11243;11350.545978161112;11367.886321137014;11914.463849126636;12034.217775844541;12059.457324420599;12633.557825476064;12674.366281686063;10607.938601275271;10786.460676966277;10802.189835762192;10812.56749730002;11044.226904116635;11326.263792853439;11597.76804463923;11631.127665425296;11832.76334473323;11857.940710296738;10751.492159335878;10826.51280692355;11079.224454288122;11085.168612353944;11325.263857849213;8545.914540854512;8604.354673399645;8661.6968406108;8907.55462226899;9044.733737276654;8317.916820831715;8464.619092140993;8477.406581539233;8809.559522023745;9121.270298375981 14:32:07 INFO - PROCESS | 3450 | __end_tp_report 14:32:07 INFO - PROCESS | 3450 | __start_cc_report 14:32:07 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,318 14:32:07 INFO - PROCESS | 3450 | __end_cc_report 14:32:07 INFO - PROCESS | 3450 | __startTimestamp1451687527835__endTimestamp 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | ------- Summary: start ------- 14:32:07 INFO - PROCESS | 3450 | Number of tests: 6 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:5353.98 Median:5584.08 stddev:598.91 (10.7%) stddev-sans-first:574.84 14:32:07 INFO - PROCESS | 3450 | Values: 3132.7 3174.4 3206.1 3221.9 3223.1 5112.7 5323.1 5342.8 5361.1 5362.8 5278.3 5300.1 5376.9 5404.1 5413.7 4902.6 4904.9 4931.8 5001.0 5006.0 4880.6 4913.2 4932.4 5008.1 5041.4 4613.3 4713.0 4857.3 4863.0 4931.7 4865.5 4872.3 4924.8 4926.9 4955.7 4762.0 4864.4 4880.5 4909.9 4957.0 5168.6 5190.0 5204.2 5208.1 5285.9 5779.4 5783.9 5797.9 5799.8 5813.1 5697.4 5839.4 5845.3 5849.4 5877.8 5316.4 5387.8 5432.3 5433.9 5449.7 5790.7 5818.1 5882.1 5883.2 5884.0 5666.2 5681.6 5712.4 5721.9 5728.1 5784.1 5793.8 5842.4 5903.1 5933.5 5669.5 5686.3 5687.9 5689.3 5710.5 5603.9 5697.9 5725.3 5725.7 5794.1 4416.6 4458.1 4480.7 4510.0 4518.3 3929.8 3981.3 3989.4 3994.5 4025.9 5231.8 5306.9 5328.4 5402.2 5462.8 5818.5 5848.9 5861.4 5867.9 5881.4 5405.0 5405.9 5407.4 5408.5 5444.9 4754.2 4978.8 4985.1 4997.2 5093.2 5834.0 5834.1 5913.5 5944.3 5959.3 5777.1 5786.4 5793.6 5832.5 5839.1 5840.4 5920.6 5979.9 5982.7 5998.9 5583.9 5626.9 5629.4 5634.3 5637.2 5690.0 5743.3 5769.6 5916.3 5920.5 5707.1 5742.4 5742.5 5746.5 5747.9 5672.2 5684.5 5734.5 5735.8 5752.2 5386.9 5510.1 5537.3 5579.3 5636.5 5617.8 5667.7 5681.6 5684.8 5686.2 5413.4 5520.3 5584.1 5611.5 5611.9 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:43662.70 Median:33839.25 stddev:73163.36 (216.2%) stddev-sans-first:73296.90 14:32:07 INFO - PROCESS | 3450 | Values: 524.6 533.4 540.6 559.4 612.4 34641.0 35218.1 35364.1 35474.5 35479.3 38172.8 38641.6 38747.2 38856.2 38866.4 8260.1 8485.2 8509.8 8518.3 8574.8 8378.9 8487.3 8487.3 8488.3 8493.9 8561.0 8671.3 8716.7 8721.1 8806.4 8590.3 8629.8 8659.4 8781.2 8800.7 8666.7 8736.2 8758.0 8762.8 8781.0 38489.2 39059.6 39235.4 39287.6 39348.0 2750.8 3030.1 3050.6 3075.2 3121.4 27053.2 28015.4 28670.1 28751.6 29240.6 3643.1 3669.2 3752.2 3835.6 3867.6 214743.0 215474.0 215523.0 215652.0 216649.0 50198.5 51118.5 52015.5 53201.5 56015.4 50893.7 51369.5 51377.5 51611.7 51625.7 14686.8 14992.4 15014.3 15066.5 15071.5 11482.1 11502.4 11523.9 11550.6 11588.7 18087.4 18127.7 18985.5 19051.4 19093.7 7288.2 7532.0 7534.7 7556.5 7618.3 896.7 973.7 1040.7 1062.7 1074.7 24393.1 24744.8 24930.0 24956.4 26258.0 989.5 1025.4 1079.7 1115.1 1157.5 15102.2 15520.5 15949.4 16054.7 16093.8 324092.0 327063.6 327239.0 327662.0 328115.0 51454.5 52488.5 52802.5 52905.0 52968.7 1286.4 1342.6 1346.1 1356.1 1356.6 28251.6 28992.3 29134.9 29258.3 29518.9 45272.5 45680.3 46248.8 46268.1 46344.0 282580.0 282834.0 283611.0 287908.0 290166.0 29830.7 30818.5 31006.5 31223.2 31269.8 36439.5 36898.3 37282.0 37368.3 37695.0 31719.8 31818.7 31848.4 32392.7 32819.3 32370.5 32427.0 34059.8 34623.5 35837.0 33353.0 33618.7 34151.5 34270.3 34665.3 29702.0 30799.8 31939.2 32132.5 32135.5 24504.4 24607.4 24692.1 24727.3 24944.6 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:29788.56 Median:322.70 stddev:91001.95 (28199.9%) stddev-sans-first:91230.34 14:32:07 INFO - PROCESS | 3450 | Values: 321.5 323.9 331.6 331.8 332.9 11313.9 11753.6 16158.8 16752.6 16896.7 17376.1 17456.9 17572.1 17944.6 18020.9 5952.5 6114.3 6135.0 6141.2 6150.2 4897.4 6045.1 6075.1 6077.1 6080.5 5939.7 6038.1 6047.1 6101.6 6123.3 5966.6 5982.5 6228.6 6442.9 6443.2 5913.5 6206.2 6227.8 6445.7 6463.6 22008.8 22315.7 23118.3 23146.9 23172.4 2125.5 2150.2 2218.8 2230.2 2233.3 10328.3 14179.3 14208.5 14325.1 14388.1 1869.3 1895.8 1953.6 1990.8 2070.3 65143.3 65233.0 67674.0 71050.6 71083.0 15079.3 15110.2 15264.5 15308.0 15385.6 12745.2 13071.4 13086.1 24018.0 24105.3 7259.4 7389.7 7537.7 7614.4 7652.9 7310.3 7347.7 7355.2 7398.0 7405.5 4513.3 4539.9 4546.7 4558.8 4575.6 1806.7 1844.8 1847.8 1849.3 1865.7 927.3 994.7 1019.1 1019.9 1046.3 16465.4 16786.7 16843.6 17158.2 17408.2 885.6 911.7 935.9 943.3 944.7 8870.6 9189.7 9236.0 9305.8 9371.7 498560.0 500384.0 556569.0 606282.0 614157.0 39429.2 80702.6 83014.5 84327.6 84687.6 1171.4 1173.0 1186.8 1200.7 1213.8 14266.1 14469.2 14473.3 14559.3 14666.2 30448.8 31608.5 32526.2 32532.8 34322.3 44641.0 45269.5 45394.0 46223.5 48777.5 9410.2 9514.8 9725.9 9852.6 9859.5 17401.6 17644.2 17807.3 17829.1 17960.8 14403.1 14483.2 14744.4 14849.9 14987.2 14355.0 14507.6 14820.4 14932.8 15108.2 15163.2 15237.2 15584.4 15798.1 15903.2 9581.6 9583.6 9592.0 9649.5 9822.5 10294.9 11918.5 14642.5 14866.0 14970.5 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:5168.98 Median:6212.58 stddev:2634.51 (42.4%) stddev-sans-first:2626.82 14:32:07 INFO - PROCESS | 3450 | Values: 1418.3 1431.4 1568.7 1752.2 1760.3 7213.7 7379.3 7384.2 7393.4 7424.0 7357.4 7384.9 7445.4 7474.7 7478.2 2082.7 2116.7 2119.4 2121.2 2127.6 2208.5 2208.9 2215.8 2221.1 2231.9 2004.6 2016.6 2152.6 2221.2 2234.9 2221.1 2247.5 2277.9 2282.6 2292.5 2250.3 2283.3 2288.5 2288.9 2295.2 7392.0 7405.2 7407.5 7478.4 7485.8 4551.9 4615.1 4615.4 4623.7 4640.8 2981.5 3000.2 3033.1 3057.4 3137.3 924.3 925.2 959.8 961.9 981.5 10065.8 10073.1 10097.9 10125.6 10136.2 3995.1 4050.1 4066.1 4107.6 4146.1 8268.8 8323.9 8388.6 8409.5 8422.9 4453.4 4466.4 4474.4 4478.4 4500.4 4075.8 4080.7 4094.5 4134.7 4139.5 3253.3 3265.8 3288.4 3309.2 3316.9 991.5 1010.5 1011.2 1011.5 1013.5 1022.6 1023.2 1068.0 1142.8 1288.3 6849.2 6891.4 6901.1 6907.2 6921.8 1166.6 1172.3 1175.9 1201.0 1227.0 5154.4 5222.2 5235.4 5241.8 5255.2 8241.9 8700.6 8718.7 8724.3 8741.7 8502.2 8535.0 8603.1 8690.1 8712.9 6723.6 6767.3 6958.5 6960.1 7131.5 6706.6 6739.6 6768.3 6780.4 6782.8 7452.3 7795.4 7870.1 7883.3 7914.5 7841.5 8171.0 8209.0 8209.1 8322.7 6239.8 6243.9 6418.6 6460.0 6462.7 7235.3 7286.7 7292.7 7300.8 7310.7 6835.1 6857.7 6918.7 6924.7 6986.8 5607.2 5652.8 6492.4 6674.9 6790.7 6735.9 6757.0 6772.2 6811.1 6817.0 6104.5 6162.3 6163.8 6185.3 6245.2 6136.0 6290.7 6299.6 6304.3 6311.8 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:5520.27 Median:6241.89 stddev:1721.67 (27.6%) stddev-sans-first:1681.48 14:32:07 INFO - PROCESS | 3450 | Values: 309.2 321.7 324.8 327.3 332.5 6222.3 6244.7 6285.6 6317.7 6387.9 6214.3 6239.1 6257.3 6260.7 6263.1 4561.4 4653.2 4676.1 4729.9 4731.1 4610.8 4629.4 4629.9 4647.7 4659.0 4577.6 4589.5 4595.8 4615.2 4646.5 4617.1 4624.3 4629.8 4649.3 4655.0 3896.0 3924.7 4015.1 4020.2 4020.4 5865.5 5884.7 5910.6 5927.9 5937.2 5417.8 5420.8 5424.5 5432.7 5443.8 6588.1 6609.4 6610.3 6620.2 6638.4 4253.2 4351.0 4392.6 4419.6 4420.8 6852.5 6918.3 6927.1 6930.9 6938.6 4546.5 4549.7 4574.8 4576.5 4601.7 4430.6 4633.5 4637.6 4640.6 4641.9 5378.5 5392.8 5404.4 5408.7 5427.8 6631.6 6651.2 6664.0 6689.0 6753.5 1627.6 1632.6 1641.2 1643.5 1645.0 1037.0 1053.5 1073.8 1073.8 1076.9 6113.5 6189.6 6224.5 6251.6 6268.4 6830.6 6888.2 6900.0 6910.7 6929.4 6047.7 6125.8 6149.1 6160.2 6166.0 3678.2 3734.2 3739.5 3742.8 3743.1 6817.8 6963.7 6980.5 7129.8 7142.2 7063.4 7104.6 7112.9 7174.4 7212.2 6962.2 7041.4 7044.0 7061.7 7068.4 6944.4 6944.6 6946.1 6946.3 6981.4 6880.8 6883.6 6892.2 6907.0 6923.8 6877.8 7057.6 7062.0 7077.5 7098.3 4459.6 4533.5 4547.6 4547.8 4561.7 6986.2 6993.8 6996.6 7002.3 7010.0 6579.7 6718.8 6719.9 6820.2 6827.1 6664.5 6699.6 6754.8 6769.8 6785.6 6671.9 6682.8 6683.5 6690.2 6691.3 6731.8 6826.9 6835.3 6840.0 6847.6 6654.0 6654.1 6656.1 6658.9 6659.0 14:32:07 INFO - PROCESS | 3450 | 14:32:07 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:12982.28 Median:44071.66 stddev:14531.46 (33.0%) stddev-sans-first:14542.97 14:32:07 INFO - PROCESS | 3450 | Values: 704.3 733.7 781.6 791.0 817.5 13270.7 13305.8 13460.9 13550.4 13581.3 12611.7 12710.7 12732.1 12742.8 12750.1 666.6 673.2 813.3 827.5 838.6 821.7 830.2 831.9 832.4 833.1 856.0 859.7 862.3 870.7 873.0 847.2 851.2 858.2 859.9 866.9 639.9 642.4 642.8 644.7 646.2 13253.5 13358.9 13508.7 13549.8 13606.3 11509.8 12349.4 12453.5 12656.0 12845.7 9705.5 9966.1 9991.3 10305.7 10393.1 3554.2 3588.4 3618.1 3644.3 3727.5 40892.6 41124.2 41438.8 41463.0 41494.4 9440.9 9636.8 9650.1 9668.3 9925.4 16685.0 17087.3 17186.1 17196.0 17240.7 6859.4 6973.4 6997.3 7087.4 7127.3 3742.5 3836.0 3858.9 3900.6 3928.0 2906.6 2959.3 2973.3 2994.6 3006.4 531.3 537.1 542.1 546.6 552.1 619.8 657.5 677.7 680.9 692.7 8042.2 8201.7 8313.5 9252.8 9618.5 543.2 629.4 684.6 686.2 699.1 4029.3 4084.2 4089.0 4231.5 4234.2 51283.7 51996.5 52506.0 53266.0 53322.2 45916.5 46598.0 46838.0 47756.8 48093.0 41700.0 42067.8 42505.8 42731.8 43369.0 7820.3 7976.3 8270.4 8445.3 8454.0 31842.4 32693.5 33123.2 33526.8 33817.0 41646.2 42515.0 42752.0 43112.8 44774.3 10765.4 11147.6 11243.0 11350.5 11367.9 11914.5 12034.2 12059.5 12633.6 12674.4 10607.9 10786.5 10802.2 10812.6 11044.2 11326.3 11597.8 11631.1 11832.8 11857.9 10751.5 10826.5 11079.2 11085.2 11325.3 8545.9 8604.4 8661.7 8907.6 9044.7 8317.9 8464.6 8477.4 8809.6 9121.3 14:32:07 INFO - PROCESS | 3450 | -------- Summary: end -------- 14:32:07 INFO - PROCESS | 3450 | 14:32:08 INFO - TEST-INFO | 3450: exit 0 14:32:08 INFO - TEST-OK | dromaeo_css | took 1114644ms 14:32:08 INFO - TEST-START | kraken 14:32:08 INFO - operating with platform_type : linux_ 14:32:08 INFO - Initialising browser for kraken test... 14:32:08 INFO - TEST-INFO | started process 3688 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Cv0nL/profile http://localhost:37259/getInfo.html) 14:32:12 INFO - PROCESS | 3688 | __metrics Screen width/height:1600/1200 14:32:12 INFO - PROCESS | 3688 | colorDepth:24 14:32:12 INFO - PROCESS | 3688 | Browser inner width/height: 1024/697 14:32:12 INFO - PROCESS | 3688 | __metrics 14:32:13 INFO - PROCESS | 3688 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:32:13 INFO - TEST-INFO | 3688: exit 0 14:32:13 INFO - Browser initialized. 14:32:13 INFO - Running cycle 1/1 for kraken test... 14:32:13 INFO - TEST-INFO | started process 3811 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9Cv0nL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:25 INFO - PROCESS | 3811 | RSS: Main: 150122496 14:32:25 INFO - PROCESS | 3811 | 14:32:28 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37259/tests/kraken/driver.html?testName=audio-beat-detection) 14:32:28 INFO - PROCESS | 3811 | RSS: Main: 150917120 14:32:28 INFO - PROCESS | 3811 | 14:32:31 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37259/tests/kraken/driver.html?testName=audio-dft) 14:32:32 INFO - PROCESS | 3811 | RSS: Main: 151904256 14:32:32 INFO - PROCESS | 3811 | 14:32:35 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37259/tests/kraken/driver.html?testName=audio-fft) 14:32:35 INFO - PROCESS | 3811 | RSS: Main: 146694144 14:32:35 INFO - PROCESS | 3811 | 14:32:37 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37259/tests/kraken/driver.html?testName=audio-oscillator) 14:32:38 INFO - PROCESS | 3811 | RSS: Main: 146710528 14:32:38 INFO - PROCESS | 3811 | 14:32:40 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:41 INFO - PROCESS | 3811 | RSS: Main: 146984960 14:32:41 INFO - PROCESS | 3811 | 14:32:44 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37259/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:44 INFO - PROCESS | 3811 | RSS: Main: 147349504 14:32:44 INFO - PROCESS | 3811 | 14:32:48 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37259/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:48 INFO - PROCESS | 3811 | RSS: Main: 149364736 14:32:48 INFO - PROCESS | 3811 | 14:32:51 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37259/tests/kraken/driver.html?testName=json-parse-financial) 14:32:52 INFO - PROCESS | 3811 | RSS: Main: 147570688 14:32:52 INFO - PROCESS | 3811 | 14:32:53 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:54 INFO - PROCESS | 3811 | RSS: Main: 148484096 14:32:54 INFO - PROCESS | 3811 | 14:32:56 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:56 INFO - PROCESS | 3811 | RSS: Main: 149176320 14:32:56 INFO - PROCESS | 3811 | 14:32:58 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:59 INFO - PROCESS | 3811 | RSS: Main: 148975616 14:32:59 INFO - PROCESS | 3811 | 14:33:02 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:33:02 INFO - PROCESS | 3811 | RSS: Main: 148496384 14:33:02 INFO - PROCESS | 3811 | 14:33:05 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:33:05 INFO - PROCESS | 3811 | RSS: Main: 148643840 14:33:05 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | Cycle 1(1): loaded http://localhost:37259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37259/tests/kraken/driver.html?testName=ai-astar) 14:33:07 INFO - PROCESS | 3811 | RSS: Main: 149958656 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | __start_tp_report 14:33:07 INFO - PROCESS | 3811 | _x_x_mozilla_page_load 14:33:07 INFO - PROCESS | 3811 | _x_x_mozilla_page_load_details 14:33:07 INFO - PROCESS | 3811 | |i|pagename|runs| 14:33:07 INFO - PROCESS | 3811 | |0;ai-astar;113;108;115;113;112;124;112;112;114;113 14:33:07 INFO - PROCESS | 3811 | |1;audio-beat-detection;152;135;151;168;130;155;147;128;164;126 14:33:07 INFO - PROCESS | 3811 | |2;audio-dft;163;162;163;163;164;161;165;163;169;165 14:33:07 INFO - PROCESS | 3811 | |3;audio-fft;74;71;74;75;72;75;72;139;74;74 14:33:07 INFO - PROCESS | 3811 | |4;audio-oscillator;97;96;138;95;97;97;138;97;98;141 14:33:07 INFO - PROCESS | 3811 | |5;imaging-gaussian-blur;110;109;110;109;110;111;110;111;110;109 14:33:07 INFO - PROCESS | 3811 | |6;imaging-darkroom;148;146;147;146;147;146;148;147;147;148 14:33:07 INFO - PROCESS | 3811 | |7;imaging-desaturate;96;97;96;96;96;97;96;96;97;96 14:33:07 INFO - PROCESS | 3811 | |8;json-parse-financial;64;62;63;62;61;61;62;62;60;72 14:33:07 INFO - PROCESS | 3811 | |9;json-stringify-tinderbox;68;68;68;69;70;69;70;69;69;69 14:33:07 INFO - PROCESS | 3811 | |10;stanford-crypto-aes;85;95;88;87;88;86;87;88;88;86 14:33:07 INFO - PROCESS | 3811 | |11;stanford-crypto-ccm;119;121;123;145;125;129;119;128;117;118 14:33:07 INFO - PROCESS | 3811 | |12;stanford-crypto-pbkdf2;143;163;158;154;151;153;156;166;154;157 14:33:07 INFO - PROCESS | 3811 | |13;stanford-crypto-sha256-iterative;68;69;70;69;68;68;71;75;70;69 14:33:07 INFO - PROCESS | 3811 | __end_tp_report 14:33:07 INFO - PROCESS | 3811 | __start_cc_report 14:33:07 INFO - PROCESS | 3811 | _x_x_mozilla_cycle_collect,769 14:33:07 INFO - PROCESS | 3811 | __end_cc_report 14:33:07 INFO - PROCESS | 3811 | __startTimestamp1451687587812__endTimestamp 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | ------- Summary: start ------- 14:33:07 INFO - PROCESS | 3811 | Number of tests: 14 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:4.09 (3.6%) stddev-sans-first:4.33 14:33:07 INFO - PROCESS | 3811 | Values: 113.0 108.0 115.0 113.0 112.0 124.0 112.0 112.0 114.0 113.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:151.50 stddev:15.09 (10.0%) stddev-sans-first:15.83 14:33:07 INFO - PROCESS | 3811 | Values: 152.0 135.0 151.0 168.0 130.0 155.0 147.0 128.0 164.0 126.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.20 (1.3%) stddev-sans-first:2.32 14:33:07 INFO - PROCESS | 3811 | Values: 163.0 162.0 163.0 163.0 164.0 161.0 165.0 163.0 169.0 165.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#3] audio-fft Cycles:10 Average:80.00 Median:74.00 stddev:20.77 (28.1%) stddev-sans-first:21.92 14:33:07 INFO - PROCESS | 3811 | Values: 74.0 71.0 74.0 75.0 72.0 75.0 72.0 139.0 74.0 74.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:97.00 stddev:20.46 (21.1%) stddev-sans-first:21.20 14:33:07 INFO - PROCESS | 3811 | Values: 97.0 96.0 138.0 95.0 97.0 97.0 138.0 97.0 98.0 141.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 14:33:07 INFO - PROCESS | 3811 | Values: 110.0 109.0 110.0 109.0 110.0 111.0 110.0 111.0 110.0 109.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:33:07 INFO - PROCESS | 3811 | Values: 148.0 146.0 147.0 146.0 147.0 146.0 148.0 147.0 147.0 148.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:33:07 INFO - PROCESS | 3811 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.00 stddev:3.38 (5.5%) stddev-sans-first:3.56 14:33:07 INFO - PROCESS | 3811 | Values: 64.0 62.0 63.0 62.0 61.0 61.0 62.0 62.0 60.0 72.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 14:33:07 INFO - PROCESS | 3811 | Values: 68.0 68.0 68.0 69.0 70.0 69.0 70.0 69.0 69.0 69.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.00 stddev:2.74 (3.1%) stddev-sans-first:2.71 14:33:07 INFO - PROCESS | 3811 | Values: 85.0 95.0 88.0 87.0 88.0 86.0 87.0 88.0 88.0 86.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.00 stddev:8.34 (6.7%) stddev-sans-first:8.62 14:33:07 INFO - PROCESS | 3811 | Values: 119.0 121.0 123.0 145.0 125.0 129.0 119.0 128.0 117.0 118.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:156.50 stddev:6.35 (4.1%) stddev-sans-first:4.86 14:33:07 INFO - PROCESS | 3811 | Values: 143.0 163.0 158.0 154.0 151.0 153.0 156.0 166.0 154.0 157.0 14:33:07 INFO - PROCESS | 3811 | 14:33:07 INFO - PROCESS | 3811 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:2.11 (3.0%) stddev-sans-first:2.15 14:33:07 INFO - PROCESS | 3811 | Values: 68.0 69.0 70.0 69.0 68.0 68.0 71.0 75.0 70.0 69.0 14:33:07 INFO - PROCESS | 3811 | -------- Summary: end -------- 14:33:07 INFO - PROCESS | 3811 | 14:33:08 INFO - TEST-INFO | 3811: exit 0 14:33:08 INFO - TEST-OK | kraken | took 60198ms 14:33:08 INFO - TEST-START | v8_7 14:33:08 INFO - operating with platform_type : linux_ 14:33:08 INFO - Initialising browser for v8_7 test... 14:33:08 INFO - TEST-INFO | started process 4097 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcbUHP6/profile http://localhost:37259/getInfo.html) 14:33:13 INFO - PROCESS | 4097 | __metrics Screen width/height:1600/1200 14:33:13 INFO - PROCESS | 4097 | colorDepth:24 14:33:13 INFO - PROCESS | 4097 | Browser inner width/height: 1024/697 14:33:13 INFO - PROCESS | 4097 | __metrics 14:33:13 INFO - PROCESS | 4097 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:33:14 INFO - TEST-INFO | 4097: exit 0 14:33:14 INFO - Browser initialized. 14:33:14 INFO - Running cycle 1/1 for v8_7 test... 14:33:14 INFO - TEST-INFO | started process 4222 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcbUHP6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:26 INFO - PROCESS | 4222 | RSS: Main: 150593536 14:33:26 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | Cycle 1(1): loaded http://localhost:37259/tests/v8_7/run.html (next: http://localhost:37259/tests/v8_7/run.html) 14:33:47 INFO - PROCESS | 4222 | RSS: Main: 147251200 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | __start_tp_report 14:33:47 INFO - PROCESS | 4222 | _x_x_mozilla_page_load 14:33:47 INFO - PROCESS | 4222 | _x_x_mozilla_page_load_details 14:33:47 INFO - PROCESS | 4222 | |i|pagename|runs| 14:33:47 INFO - PROCESS | 4222 | |0;Richards;167.16817118020728 14:33:47 INFO - PROCESS | 4222 | |1;DeltaBlue;191.60758766047135 14:33:47 INFO - PROCESS | 4222 | |2;Encrypt;280.58361391694723 14:33:47 INFO - PROCESS | 4222 | |3;Decrypt;5240.837696335078 14:33:47 INFO - PROCESS | 4222 | |4;RayTrace;1081.081081081081 14:33:47 INFO - PROCESS | 4222 | |5;Earley;721.5007215007215 14:33:47 INFO - PROCESS | 4222 | |6;Boyer;12382.716049382716 14:33:47 INFO - PROCESS | 4222 | |7;RegExp;25846.153846153848 14:33:47 INFO - PROCESS | 4222 | |8;Splay;561.6591928251121 14:33:47 INFO - PROCESS | 4222 | |9;NavierStokes;4835.748792270531 14:33:47 INFO - PROCESS | 4222 | __end_tp_report 14:33:47 INFO - PROCESS | 4222 | __startTimestamp1451687627806__endTimestamp 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | ------- Summary: start ------- 14:33:47 INFO - PROCESS | 4222 | Number of tests: 10 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 167.2 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#1] DeltaBlue Cycles:1 Average:191.61 Median:191.61 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 191.6 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 280.6 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 5240.8 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#4] RayTrace Cycles:1 Average:1081.08 Median:1081.08 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 1081.1 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#5] Earley Cycles:1 Average:721.50 Median:721.50 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 721.5 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 12382.7 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#7] RegExp Cycles:1 Average:25846.15 Median:25846.15 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 25846.2 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#8] Splay Cycles:1 Average:561.66 Median:561.66 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 561.7 14:33:47 INFO - PROCESS | 4222 | 14:33:47 INFO - PROCESS | 4222 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:33:47 INFO - PROCESS | 4222 | Values: 4835.7 14:33:47 INFO - PROCESS | 4222 | -------- Summary: end -------- 14:33:47 INFO - PROCESS | 4222 | 14:33:48 INFO - TEST-INFO | 4222: exit 0 14:33:48 INFO - TEST-OK | v8_7 | took 39946ms 14:33:48 INFO - SUITE-END | took 1214s 14:33:48 INFO - Completed test suite (00:20:14) 14:33:48 INFO - Working with test: dromaeo_css 14:33:48 INFO - Generating results file: dromaeo_css 14:33:48 INFO - Working with test: kraken 14:33:48 INFO - Generating results file: kraken 14:33:48 INFO - javascript benchmark 14:33:48 INFO - Working with test: v8_7 14:33:48 INFO - Generating results file: v8_7 14:33:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:33:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 14:33:48 INFO - process_Request line: dromaeo_css 6955.86 graph.html#tests=[[72,64,43]] 14:33:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:33:48 INFO - process_Request line: kraken 1534.80 graph.html#tests=[[232,64,43]] 14:33:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:33:49 INFO - process_Request line: v8_7 21333.40 graph.html#tests=[[230,64,43]] 14:33:49 INFO - RETURN: dromaeo_css: 6955.86 14:33:49 INFO - RETURN: kraken: 1534.80 14:33:49 INFO - RETURN: v8_7: 21333.40 14:33:49 INFO - javascript benchmark 14:33:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3132.7493800495963, 3174.380995705837, 3206.134343727192, 3221.8550165242564, 3223.129754966159, 5112.744362781856, 5323.121684921988, 5342.786288548458, 5361.088614935461, 5362.839114826552, 5278.261043453919, 5300.09898317286, 5376.91934620981, 5404.081306177949, 5413.675179489233, 4902.60779137669, 4904.852854414374, 4931.753412329387, 5001.0, 5006.0, 4880.633952453562, 4913.238448040559, 4932.383452068491, 5008.073506401309, 5041.395032596093, 4613.308003799423, 4713.0, 4857.319975203474, 4862.975685121552, 4931.65478416511, 4865.464798872121, 4872.293517439952, 4924.827631032933, 4926.8768280793265, 4955.702657840505, 4762.0, 4864.391951006124, 4880.463149053601, 4909.901801963976, 4956.950430495721, 5168.61235407346, 5189.974050129763, 5204.219367094928, 5208.088584497697, 5285.894282114375, 5779.422057794229, 5783.913241301384, 5797.942020579824, 5799.82600521985, 5813.09896965971, 5697.401772813878, 5839.416058394169, 5845.298564172284, 5849.356570777211, 5877.764889404461, 5316.362036555638, 5387.757550910218, 5432.266644003049, 5433.918491222635, 5449.6730196188355, 5790.71046447676, 5818.0981947798155, 5882.058870580687, 5883.17635531026, 5884.0, 5666.206731057655, 5681.57388195887, 5712.371639119693, 5721.8569535761935, 5728.112142617818, 5784.132380142928, 5793.826185214451, 5842.357340692521, 5903.0555111182, 5933.495652869555, 5669.461401166965, 5686.2607860977805, 5687.9431205687415, 5689.260396148474, 5710.514606258432, 5603.915941260884, 5697.9430205698245, 5725.2843394575675, 5725.742341594639, 5794.130880367894, 4416.6025057744955, 4458.130664520452, 4480.663950203748, 4510.0, 4518.322251662211, 3929.7838618876235, 3981.343078392033, 3989.3816458448987, 3994.5206575210577, 4025.879223623296, 5231.764570594332, 5306.8938621228135, 5328.36059672834, 5402.216678581583, 5462.781488740486, 5818.505427038749, 5848.853778655568, 5861.443162899518, 5867.882642347129, 5881.382454842265, 5405.0, 5405.918911216335, 5407.405185429599, 5408.513233808976, 5444.863878402993, 4754.21555443348, 4978.800847966041, 4985.077760614298, 4997.200447928314, 5093.18509038552, 5834.0373838317055, 5834.066549352084, 5913.467787899023, 5944.3164036136395, 5959.255093113361, 5777.104548794776, 5786.392428794916, 5793.594448388572, 5832.533397328289, 5839.124131380327, 5840.386759390203, 5920.644761314335, 5979.880402392015, 5982.730777115127, 5998.88002239944, 5583.944160558505, 5626.85932851682, 5629.408912064175, 5634.32388113429, 5637.182608521824, 5689.971550142222, 5743.282089738783, 5769.567282453749, 5916.3492015877355, 5920.467157955804, 5707.1153971134545, 5742.397048309867, 5742.5118864895285, 5746.511546518593, 5747.913781293368, 5672.234248376416, 5684.516816070681, 5734.455226753618, 5735.827925162252, 5752.223449834219, 5386.8956863843605, 5510.0632892409185, 5537.335519737658, 5579.3304803422225, 5636.549076073986, 5617.775288988395, 5667.716614169358, 5681.630694004876, 5684.77260909559, 5686.175504551899, 5413.431589683027, 5520.282363292747, 5584.078627026495, 5611.5230205433, 5611.943880561143], "unit": "score", "name": "dojo.html", "value": 5314.825622061601}, {"lowerIsBetter": false, "replicates": [524.6327570700511, 533.3732863884935, 540.5648452995338, 559.44614831317, 612.3845535237086, 34641.0, 35218.11954701134, 35364.11589710255, 35474.46788298171, 35479.2904141917, 38172.80913595428, 38641.61358386415, 38747.22505549887, 38856.22287554247, 38866.41700374489, 8260.050094239165, 8485.193906578865, 8509.829803403929, 8518.27594654455, 8574.828503429928, 8378.916210837875, 8487.278581320596, 8487.278581320596, 8488.278496327788, 8493.853329800491, 8561.0, 8671.262942649882, 8716.738497845075, 8721.12788721126, 8806.427582207136, 8590.269827064707, 8629.827403451958, 8659.393842431033, 8781.165789250012, 8800.735977920673, 8666.696665616673, 8736.170063843925, 8758.036615972238, 8762.780930476725, 8780.956095219546, 38489.230215395815, 39059.60940390588, 39235.41146882799, 39287.60712392868, 39348.0, 2750.8349499030123, 3030.1364111228195, 3050.6186726659166, 3075.1850759548515, 3121.391328690906, 27053.1884043479, 28015.439691206062, 28670.13989580295, 28751.56872646912, 29240.56139157893, 3643.125649844045, 3669.2478042001326, 3752.212035472554, 3835.5780864104927, 3867.57456679765, 214743.0, 215474.0, 215522.99999999843, 215652.0, 216649.0, 50198.498015020115, 51118.48881511212, 52015.47984520182, 53201.46798531965, 56015.43984560184, 50893.74553127285, 51369.486305137216, 51377.48622513802, 51611.741941290056, 51625.741871290404, 14686.779698304534, 14992.400303987937, 15014.324355404033, 15066.54800355991, 15071.4724984625, 11482.0814334853, 11502.424878756028, 11523.942380288212, 11550.59572914944, 11588.710282243012, 18087.366942157223, 18127.731058825757, 18985.525361866064, 19051.428457146307, 19093.71359429582, 7288.234735352712, 7532.0, 7534.736284230025, 7556.546607203585, 7618.314351708373, 896.6771962093641, 973.7030205787162, 1040.661784919889, 1062.7396287909512, 1074.6722249713912, 24393.14623988152, 24744.752552474605, 24930.0, 24956.376090597518, 26258.0, 989.4557993103908, 1025.4206373399006, 1079.7030816525519, 1115.0522056252282, 1157.5427706056062, 15102.244887755569, 15520.456784012731, 15949.362025518849, 16054.678906421806, 16093.839061609468, 324092.0, 327063.6468176629, 327239.0, 327662.0, 328115.0, 51454.48545514497, 52488.47511524836, 52802.471975280525, 52905.0, 52968.73515632474, 1286.4275397448046, 1342.5905098944916, 1346.07121086452, 1356.1117468058635, 1356.5998030581002, 28251.57622635621, 28992.275193120342, 29134.854325728236, 29258.268543286587, 29518.852405737834, 45272.54727452815, 45680.31479527876, 46248.76875615735, 46268.07463850637, 46344.0, 282580.0, 282834.0, 283611.0, 287908.0, 290166.0, 29830.70169298279, 30818.53772193374, 31006.53490197694, 31223.219419514695, 31269.84365078251, 36439.453408198366, 36898.26203475969, 37282.0, 37368.25263494769, 37695.0, 31719.841400792848, 31818.68181318157, 31848.36303273968, 32392.676073238967, 32819.34361312808, 32370.514442282914, 32427.0, 34059.82970085134, 34623.4806477898, 35837.0, 33353.0, 33618.663813361556, 34151.4877276846, 34270.314593708485, 34665.306693866485, 29702.0, 30799.846000769852, 31939.201519962186, 32132.518012230303, 32135.51796723098, 24504.38739031467, 24607.38481537976, 24692.13577524778, 24727.25818225456, 24944.625830612917], "unit": "score", "name": "ext.html", "value": 17656.658689474847}, {"lowerIsBetter": false, "replicates": [321.53056537455313, 323.8753080064175, 331.6236072058216, 331.8125259228536, 332.94339962206425, 11313.943430282838, 11753.588624398148, 16158.83841161588, 16752.581185470368, 16896.662066758672, 17376.131193440342, 17456.912715436403, 17572.121393930283, 17944.55138621535, 18020.909895450506, 5952.494038006764, 6114.296855861566, 6135.049067394539, 6141.232345956755, 6150.1697270868535, 4897.4123105227245, 6045.123457098718, 6075.088736689488, 6077.149199112106, 6080.452759251666, 5939.703014849262, 6038.124471951564, 6047.092936059582, 6101.603395779282, 6123.326434092269, 5966.582339236255, 5982.521398288149, 6228.564000519988, 6442.93557064428, 6443.226812782496, 5913.497352725023, 6206.193194884681, 6227.844303892393, 6445.709943052574, 6463.57986730861, 22008.779912200833, 22315.665265021038, 23118.306450806336, 23146.884265578563, 23172.42068948273, 2125.4792575819024, 2150.193677370986, 2218.811401030914, 2230.241717815934, 2233.3300009996938, 10328.328658637165, 14179.29103544829, 14208.502702405367, 14325.140491570539, 14388.136711797326, 1869.3457289948544, 1895.8293753562107, 1953.6092781443626, 1990.7611086669692, 2070.3271436782957, 65143.3485665142, 65233.0, 67674.0, 71050.64474677645, 71083.0, 15079.321430535652, 15110.244487775568, 15264.465743698916, 15308.0, 15385.615359615875, 12745.171563848506, 13071.41178646963, 13086.08397412191, 24018.0, 24105.276841694777, 7259.382952449101, 7389.66746496409, 7537.660805263777, 7614.428917831185, 7652.885206721904, 7310.342069213796, 7347.742829000959, 7355.154157271875, 7398.03825502692, 7405.481616286916, 4513.277875539898, 4539.909201815945, 4546.727196368229, 4558.772061396917, 4575.633949284049, 1806.719958406449, 1844.7601811764653, 1847.78750443698, 1849.2972670385168, 1865.720141978714, 927.2535608834818, 994.7165057958592, 1019.0624625344701, 1019.8521214423866, 1046.26238501856, 16465.423710170326, 16786.664266714597, 16843.578910527336, 17158.227879745442, 17408.21663025167, 885.6014793343021, 911.7082533589321, 935.9391639543408, 943.2831048403262, 944.6929747831982, 8870.600822962982, 9189.678361257324, 9236.0, 9305.813883722423, 9371.671991480402, 498560.0, 500384.0, 556569.0, 606282.0, 614157.0, 39429.2114157721, 80702.59648701837, 83014.50956471315, 84327.5783621078, 84687.57656211803, 1171.37916904041, 1172.976540469186, 1186.8397766301612, 1200.6578125234266, 1213.7754515414676, 14266.144031358152, 14469.204193769443, 14473.276336182938, 14559.27203639835, 14666.193359365338, 30448.84775576108, 31608.525872112397, 32526.186845329055, 32532.83733581317, 34322.313553729284, 44641.0, 45269.54730452785, 45394.0, 46223.53776462192, 48777.5122248773, 9410.153086222273, 9514.762130946781, 9725.85411218818, 9852.605895764089, 9859.457729824928, 17401.564960875574, 17644.206010729806, 17807.287708491516, 17829.10854457298, 17960.820391795914, 14403.135811851322, 14483.203423811792, 14744.410223590936, 14849.851501485278, 14987.17570533631, 14355.0, 14507.564773056825, 14820.40718371253, 14932.7760083601, 15108.244587770349, 15163.166025868242, 15237.161956092077, 15584.376624935328, 15798.052116872565, 15903.204839758197, 9581.616735330788, 9583.616655333708, 9591.952040239754, 9649.469279189712, 9822.459764712723, 10294.919033501374, 11918.52325906954, 14642.487512936996, 14866.0, 14970.47603333878], "unit": "score", "name": "jquery.html", "value": 9348.347021111476}, {"lowerIsBetter": false, "replicates": [1418.3405415663672, 1431.4274290283886, 1568.6862627474509, 1752.2465339903836, 1760.3134777436794, 7213.675384607692, 7379.262073792618, 7384.150822655396, 7393.445491588139, 7424.034875466182, 7357.448191385641, 7384.929185268133, 7445.404367650575, 7474.738384156555, 7478.177400485943, 2082.7084208210863, 2116.7459904811367, 2119.3747844385866, 2121.1621409543222, 2127.6383014887506, 2208.536207396449, 2208.933731988043, 2215.7562668106493, 2221.133757834446, 2231.9218827341047, 2004.5589970206531, 2016.5664382157834, 2152.5694861027855, 2221.1892659179366, 2234.910603575855, 2221.1226565506536, 2247.494313779395, 2277.908883644652, 2282.611955967473, 2292.495650956787, 2250.2799104286637, 2283.3378320287097, 2288.4622113803243, 2288.9356449251013, 2295.162265772981, 7391.963040184818, 7405.1854296027395, 7407.481476296662, 7478.4391170661875, 7485.775426737152, 4551.908961820745, 4615.076984603093, 4615.353850460938, 4623.722576645412, 4640.79116439761, 2981.4782413077623, 3000.159955212522, 3033.0597514770493, 3057.3885222955496, 3137.325475022881, 924.3390975452584, 925.2181906289175, 959.7552624080814, 961.927855410847, 981.5239608789731, 10065.798684026278, 10073.143782778472, 10097.899021009769, 10125.594976200942, 10136.239782016379, 3995.1210733639136, 4050.0684842485803, 4066.0851308455362, 4107.589241075928, 4146.108586653884, 8268.793280168044, 8323.875141872877, 8388.622511986976, 8409.453385529921, 8422.915770842335, 4453.421055262795, 4466.3523789050405, 4474.373587697725, 4478.350639157304, 4500.437445319335, 4075.7758323292505, 4080.6939479539155, 4094.549599544048, 4134.73124246923, 4139.503259608866, 3253.2680146966745, 3265.7877237979455, 3288.358770039867, 3309.1561651778643, 3316.8507417166284, 991.4794732765212, 1010.4695035106481, 1011.1657882247175, 1011.544804837826, 1013.45780007697, 1022.5807418958192, 1023.22746326523, 1067.957281708723, 1142.782871254459, 1288.3429450980068, 6849.1780986281965, 6891.448684105259, 6901.102856628606, 6907.240203577602, 6921.757738479129, 1166.5975238542858, 1172.3317708905843, 1175.8647755508225, 1200.9855263289207, 1226.993865030687, 5154.407243167008, 5222.164453687392, 5235.3717553893775, 5241.842744717665, 5255.185446255837, 8241.876371854427, 8700.608472618747, 8718.651253949898, 8724.302055835518, 8741.694040708544, 8502.234798868009, 8535.0, 8603.09667484905, 8690.130986901258, 8712.912870871336, 6723.55443579623, 6767.323267673193, 6958.478114141359, 6960.129983752031, 7131.465140114512, 6706.631135287411, 6739.5619284746335, 6768.323167683192, 6780.423663988616, 6782.796516104525, 7452.292032256927, 7795.415343849348, 7870.134285228734, 7883.251091146332, 7914.525128492079, 7841.451098423056, 8170.959145204236, 8208.958955205186, 8209.138040505899, 8322.70870519529, 6239.844003899939, 6243.906341404973, 6418.550701450854, 6459.967700161469, 6462.676866156579, 7235.3488186063505, 7286.708531658886, 7292.671829767779, 7300.780976570712, 7310.744123955636, 6835.111435513351, 6857.657117144023, 6918.7232510699005, 6924.653767311514, 6986.755463558751, 5607.186957891165, 5652.802151924663, 6492.383223593751, 6674.9332506676255, 6790.660466976533, 6735.922252439586, 6757.0, 6772.221194562689, 6811.114555107804, 6817.0, 6104.481119104926, 6162.26052873658, 6163.7842675506145, 6185.319614842274, 6245.219347581552, 6136.0, 6290.748370065146, 6299.622022678654, 6304.306526282014, 6311.779087731908], "unit": "score", "name": "mootools.html", "value": 4272.688291534098}, {"lowerIsBetter": false, "replicates": [309.23464425546774, 321.7136748294018, 324.81647868954025, 327.3420424945858, 332.4630721384964, 6222.284437289707, 6244.687765611712, 6285.5914365566205, 6317.747290108396, 6387.872242555146, 6214.285357183925, 6239.095331176976, 6257.311695713479, 6260.718267677954, 6263.091851681504, 4561.407017087774, 4653.1856925038155, 4676.111538807616, 4729.9054018919605, 4731.148393289207, 4610.838620648278, 4629.375034370368, 4629.884252893671, 4647.721136731807, 4658.976705116486, 4577.588017078462, 4589.5410458954175, 4595.793189306489, 4615.238485649864, 4646.53534646536, 4617.07658468306, 4624.306354046887, 4629.768511574408, 4649.279361698942, 4654.999999999983, 3895.961040389588, 3924.6860251180124, 4015.0966032642714, 4020.2361551305157, 4020.3768415895584, 5865.530757539429, 5884.705764711747, 5910.586258961875, 5927.911081333784, 5937.228160339128, 5417.783288668488, 5420.83737487876, 5424.511793938565, 5432.70120143392, 5443.8094666686875, 6588.110605068302, 6609.405153536205, 6610.338966103399, 6620.238672552622, 6638.435732962704, 4253.213155566199, 4350.956490435118, 4392.648588112943, 4419.602235798793, 4420.801063952098, 6852.5203235773515, 6918.342757438036, 6927.064846245743, 6930.9157424945915, 6938.618375989318, 4546.52261512543, 4549.7497637629585, 4574.794134263966, 4576.450825900846, 4601.723896566216, 4430.645548356124, 4633.4671512775785, 4637.628989680885, 4640.628749700016, 4641.907161856744, 5378.462153784669, 5392.757325920343, 5404.432534583812, 5408.675479471166, 5427.782888684487, 6631.607362453842, 6651.201855777338, 6664.0, 6688.966555167193, 6753.527253092237, 1627.6337823989745, 1632.583691158747, 1641.2040160522138, 1643.4658735910878, 1644.9506514804336, 1036.9896301037045, 1053.4732633683159, 1073.8281874899978, 1073.838924161382, 1076.9299995500423, 6113.510919126459, 6189.6286222826775, 6224.502039836802, 6251.562390632612, 6268.435840774352, 6830.556013859084, 6888.173419189629, 6899.965500172568, 6910.723571057101, 6929.445644348541, 6047.697615119227, 6125.754969801247, 6149.077638354193, 6160.168377269101, 6166.044263139221, 3678.2459595782802, 3734.2158146788934, 3739.457778622085, 3742.7567208131386, 3743.0642339415144, 6817.761378351734, 6963.721451141999, 6980.476464265201, 7129.750458733919, 7142.178649455275, 7063.364297213276, 7104.644767761694, 7112.893306600405, 7174.354308112191, 7212.242714515005, 6962.1645402551, 7041.401480874183, 7044.0, 7061.717531298793, 7068.399186069241, 6944.4444444445335, 6944.583325000516, 6946.097007389007, 6946.305369463215, 6981.371676549135, 6880.759173428906, 6883.586984780929, 6892.241853396022, 6906.963955406729, 6923.757668481579, 6877.828054298482, 7057.576545407292, 7061.964690176722, 7077.504574679723, 7098.325659062587, 4459.643228541774, 4533.478649955166, 4547.613452856412, 4547.840825571089, 4561.703489273186, 6986.196587392312, 6993.790186294419, 6996.580205187705, 7002.264762199896, 7010.0, 6579.671016449254, 6718.798436046926, 6719.865602688016, 6820.215675197416, 6827.078344423439, 6664.4668426524795, 6699.598024118569, 6754.797356079325, 6769.830754231184, 6785.626790526371, 6671.899921501278, 6682.799516014527, 6683.498737594603, 6690.19717633887, 6691.263960964193, 6731.764388246388, 6826.873565861776, 6835.316468353125, 6840.0, 6847.554908930903, 6654.035164901159, 6654.101696271135, 6656.101426307387, 6658.933410665832, 6659.034440006075], "unit": "score", "name": "prototype.html", "value": 4948.091440257538}, {"lowerIsBetter": false, "replicates": [704.2534912992229, 733.7431898835407, 781.5818537082662, 790.9841803163933, 817.4727300890924, 13270.734585308288, 13305.800412993789, 13460.865391346084, 13550.390232439539, 13581.3209339533, 12611.747765044694, 12710.745785084293, 12732.108752387336, 12742.80885786714, 12750.10749247553, 666.580054565623, 673.2358772792891, 813.2802469814197, 827.5200383777425, 838.6351936907434, 821.7000794709918, 830.219593582034, 831.9417640765149, 832.367400775409, 833.0794472108294, 856.0, 859.7119964811795, 862.3015357560365, 870.7126648206076, 872.9742552500818, 847.174005344787, 851.1701091435863, 858.2233079063426, 859.8624220124781, 866.9219770220648, 639.8944174211249, 642.4410762636536, 642.7653906324205, 644.7227692092398, 646.2406672160193, 13253.46986120554, 13358.933205333911, 13508.729825403536, 13549.796753048613, 13606.319684015858, 11509.827352589718, 12349.382530873421, 12453.501859925593, 12656.0, 12845.67885802853, 9705.466199359033, 9966.053224943618, 9991.300608957376, 10305.74235644115, 10393.075946710378, 3554.1647712787476, 3588.3540962626716, 3618.113562177257, 3644.325799727059, 3727.5340582427198, 40892.59107408918, 41124.177516449505, 41438.79280603577, 41462.9999999997, 41494.37758433626, 9440.858387124199, 9636.807263854684, 9650.08324209199, 9668.274879384075, 9925.404475731479, 16685.0, 17087.31650733957, 17186.140692965302, 17196.0, 17240.65518689644, 6859.382655560924, 6973.372396484341, 6997.335253150943, 7087.433005359559, 7127.322904324081, 3742.5134732484603, 3836.0026393137427, 3858.9421158682644, 3900.551436584772, 3928.017995501125, 2906.5640153977074, 2959.2749776304513, 2973.2864112612815, 2994.5508173773674, 3006.3536339686634, 531.2933798048663, 537.052103038138, 542.0892899928159, 546.5572885962383, 552.1414200917532, 619.8357435279654, 657.523295610688, 677.7051982387677, 680.8706345794283, 692.6848284030754, 8042.235987581171, 8201.71294004707, 8313.45962512447, 9252.814943701223, 9618.547270446132, 543.1743749500737, 629.4484096701652, 684.565301033847, 686.2417029182781, 699.0702365853402, 4029.274730548471, 4084.1831633673382, 4089.0041216607397, 4231.4742599391375, 4234.195502854509, 51283.7435812826, 51996.48003519992, 52506.0, 53266.0, 53322.20016699753, 45916.54083459123, 46598.0, 46838.0, 47756.76121619439, 48093.03813923772, 41700.0, 42067.7896610515, 42505.787471062446, 42731.786341068095, 43369.0, 7820.335271501986, 7976.282134607914, 8270.421070525006, 8445.324374049938, 8453.95773021131, 31842.363152737278, 32693.509597355584, 33123.171920701214, 33526.83236583899, 33817.0, 41646.1670766589, 42515.0, 42752.0, 43112.78443607762, 44774.3283850736, 10765.3540787553, 11147.55409783632, 11243.0, 11350.545978161112, 11367.886321137014, 11914.463849126636, 12034.217775844541, 12059.457324420599, 12633.557825476064, 12674.366281686063, 10607.938601275271, 10786.460676966277, 10802.189835762192, 10812.56749730002, 11044.226904116635, 11326.263792853439, 11597.76804463923, 11631.127665425296, 11832.76334473323, 11857.940710296738, 10751.492159335878, 10826.51280692355, 11079.224454288122, 11085.168612353944, 11325.263857849213, 8545.914540854512, 8604.354673399645, 8661.6968406108, 8907.55462226899, 9044.733737276654, 8317.916820831715, 8464.619092140993, 8477.406581539233, 8809.559522023745, 9121.270298375981], "unit": "score", "name": "yui.html", "value": 6106.538176023979}], "name": "dromaeo_css", "value": 6955.860141499775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 115.0, 113.0, 112.0, 124.0, 112.0, 112.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.6}, {"lowerIsBetter": true, "replicates": [152.0, 135.0, 151.0, 168.0, 130.0, 155.0, 147.0, 128.0, 164.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 163.0, 164.0, 161.0, 165.0, 163.0, 169.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 74.0, 75.0, 72.0, 75.0, 72.0, 139.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 95.0, 97.0, 97.0, 138.0, 97.0, 98.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 110.0, 111.0, 110.0, 111.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 63.0, 62.0, 61.0, 61.0, 62.0, 62.0, 60.0, 72.0], "unit": "score", "name": "json-parse-financial", "value": 62.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 88.0, 87.0, 88.0, 86.0, 87.0, 88.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [119.0, 121.0, 123.0, 145.0, 125.0, 129.0, 119.0, 128.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [143.0, 163.0, 158.0, 154.0, 151.0, 153.0, 156.0, 166.0, 154.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 155.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 68.0, 68.0, 71.0, 75.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1534.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [191.60758766047135], "unit": "score", "name": "DeltaBlue", "value": 345.06984200000005}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1081.081081081081], "unit": "score", "name": "RayTrace", "value": 684.4898250000002}, {"lowerIsBetter": false, "replicates": [721.5007215007215], "unit": "score", "name": "Earley", "value": 923.7177179999996}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [25846.153846153848], "unit": "score", "name": "RegExp", "value": 35.24644345238097}, {"lowerIsBetter": false, "replicates": [561.6591928251121], "unit": "score", "name": "Splay", "value": 145.0897644710579}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21333.402253445092}]} 14:33:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21333.40"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1534.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6955.86"}}} 14:33:49 INFO - Return code: 0 14:33:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:33:49 INFO - # TBPL SUCCESS # 14:33:49 INFO - Running post-action listener: _resource_record_post_action 14:33:49 INFO - Running post-run listener: _resource_record_post_run 14:33:50 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 10416128; Write bytes: 450867200; Read time: 3192; Write time: 508828 14:33:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7221248; Read time: 0; Write time: 472 14:33:50 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8654848; Write bytes: 443645952; Read time: 3160; Write time: 508356 14:33:50 INFO - Running post-run listener: _upload_blobber_files 14:33:50 INFO - Blob upload gear active. 14:33:50 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:33:50 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 14:33:50 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'] 14:33:50 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 14:33:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:51 INFO - (blobuploader) - INFO - Done attempting. 14:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:33:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:33:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:33:52 INFO - (blobuploader) - INFO - Done attempting. 14:33:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:33:52 INFO - Return code: 0 14:33:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:33:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:33:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8019dbb2bd9e58b4e6a0418f561da538e9aa0702952c36da02d81b1bca0bc94a4154cab8b9a5e37360689ea62a64c7168d2245953ca1655b7542d2da4072469d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbe77f29532cbee77b2b2cdb5994a1c20d1988dad4bab11007ed919a214330d8dd2d73d7f940b48617464b25e2ea741b122c6078debfc45bf6366fbd66c4594"} 14:33:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:33:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:33:52 INFO - Contents: 14:33:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8019dbb2bd9e58b4e6a0418f561da538e9aa0702952c36da02d81b1bca0bc94a4154cab8b9a5e37360689ea62a64c7168d2245953ca1655b7542d2da4072469d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbe77f29532cbee77b2b2cdb5994a1c20d1988dad4bab11007ed919a214330d8dd2d73d7f940b48617464b25e2ea741b122c6078debfc45bf6366fbd66c4594"} 14:33:52 INFO - Copying logs to upload dir... 14:33:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.071555 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-01-01 14:33:52.591119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 14:33:52.595028) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8019dbb2bd9e58b4e6a0418f561da538e9aa0702952c36da02d81b1bca0bc94a4154cab8b9a5e37360689ea62a64c7168d2245953ca1655b7542d2da4072469d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbe77f29532cbee77b2b2cdb5994a1c20d1988dad4bab11007ed919a214330d8dd2d73d7f940b48617464b25e2ea741b122c6078debfc45bf6366fbd66c4594"} build_url:https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/Cnhh29XjQPmtKUus9LHouw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8019dbb2bd9e58b4e6a0418f561da538e9aa0702952c36da02d81b1bca0bc94a4154cab8b9a5e37360689ea62a64c7168d2245953ca1655b7542d2da4072469d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3cbe77f29532cbee77b2b2cdb5994a1c20d1988dad4bab11007ed919a214330d8dd2d73d7f940b48617464b25e2ea741b122c6078debfc45bf6366fbd66c4594"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-01 14:33:52.622735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:33:52.623290) ========= 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=752f8c75933e5bfb3b8f10bb000001ce-1451682976.660017-1736361366 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-01 14:33:52.674785) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 14:33:52.675286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-01 14:33:52.675781) ========= ========= Total master_lag: 0.20 =========