builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1451436324.8 results: success (0) buildid: 20151229143006 builduid: b76f9b0b81e84303adf0dc98219b67a8 revision: ab22ba41b8fce8eaf15ed4128f6c978b20b8b238 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:24.799085) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:24.799521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:24.799830) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006164 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:24.883663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:24.884237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.019686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.020200) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033932 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.093351) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.093667) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.094082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.094359) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-29 16:45:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2015-12-29 16:45:25 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.312103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.312486) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.038435 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.363735) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.364084) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ab22ba41b8fce8eaf15ed4128f6c978b20b8b238 --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 ab22ba41b8fce8eaf15ed4128f6c978b20b8b238 --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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-29 16:45:25,441 truncating revision to first 12 chars 2015-12-29 16:45:25,441 Setting DEBUG logging. 2015-12-29 16:45:25,441 attempt 1/10 2015-12-29 16:45:25,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ab22ba41b8fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-29 16:45:25,681 unpacking tar archive at: fx-team-ab22ba41b8fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.532880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.908472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.908770) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.924533) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.924828) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-29 16:45:25.925280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-29 16:45:25.925611) ========= /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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:26 INFO - MultiFileLogger online at 20151229 16:45:26 in /builds/slave/test-pgo 16:45:26 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 16:45:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 16:45:26 INFO - {'append_to_log': False, 16:45:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 16:45:26 INFO - 'blob_upload_branch': 'Fx-Team', 16:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 16:45:26 INFO - 'branch': 'Fx-Team', 16:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:26 INFO - 'config_files': ('talos/linux_config.py',), 16:45:26 INFO - 'default_actions': ('clobber', 16:45:26 INFO - 'read-buildbot-config', 16:45:26 INFO - 'download-and-extract', 16:45:26 INFO - 'populate-webroot', 16:45:26 INFO - 'create-virtualenv', 16:45:26 INFO - 'install', 16:45:26 INFO - 'run-tests'), 16:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:26 INFO - 'download_minidump_stackwalk': True, 16:45:26 INFO - 'download_symbols': 'ondemand', 16:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:26 INFO - 'installer_path': 'installer.exe', 16:45:26 INFO - 'log_level': 'info', 16:45:26 INFO - 'log_name': 'talos', 16:45:26 INFO - 'log_to_console': True, 16:45:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:26 INFO - 'opt_config_files': (), 16:45:26 INFO - 'pip_index': False, 16:45:26 INFO - 'sps_profile': False, 16:45:26 INFO - 'sps_profile_interval': 0, 16:45:26 INFO - 'suite': 'dromaeojs-e10s', 16:45:26 INFO - 'system_bits': '32', 16:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:26 INFO - 'title': 'talos-linux64-ix-027', 16:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:26 INFO - 'use_talos_json': True, 16:45:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 16:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:26 INFO - 'work_dir': 'build'} 16:45:26 INFO - ##### 16:45:26 INFO - ##### Running clobber step. 16:45:26 INFO - ##### 16:45:26 INFO - Running pre-action listener: _resource_record_pre_action 16:45:26 INFO - Running main action method: clobber 16:45:26 INFO - rmtree: /builds/slave/test-pgo/build 16:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 16:45:27 INFO - Running post-action listener: _resource_record_post_action 16:45:27 INFO - ##### 16:45:27 INFO - ##### Running read-buildbot-config step. 16:45:27 INFO - ##### 16:45:27 INFO - Running pre-action listener: _resource_record_pre_action 16:45:27 INFO - Running main action method: read_buildbot_config 16:45:27 INFO - Using buildbot properties: 16:45:27 INFO - { 16:45:27 INFO - "project": "", 16:45:27 INFO - "product": "firefox", 16:45:27 INFO - "script_repo_revision": "production", 16:45:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 16:45:27 INFO - "repository": "", 16:45:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 16:45:27 INFO - "buildid": "20151229143006", 16:45:27 INFO - "pgo_build": "True", 16:45:27 INFO - "basedir": "/builds/slave/test-pgo", 16:45:27 INFO - "buildnumber": 412, 16:45:27 INFO - "slavename": "talos-linux64-ix-027", 16:45:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:45:27 INFO - "platform": "ubuntu64_hw", 16:45:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:45:27 INFO - "branch": "fx-team", 16:45:27 INFO - "repo_path": "integration/fx-team", 16:45:27 INFO - "revision": "ab22ba41b8fce8eaf15ed4128f6c978b20b8b238", 16:45:27 INFO - "stage_platform": "linux64-pgo", 16:45:27 INFO - "builduid": "b76f9b0b81e84303adf0dc98219b67a8", 16:45:27 INFO - "slavebuilddir": "test" 16:45:27 INFO - } 16:45:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:45:27 INFO - Running post-action listener: _resource_record_post_action 16:45:27 INFO - ##### 16:45:27 INFO - ##### Running download-and-extract step. 16:45:27 INFO - ##### 16:45:27 INFO - Running pre-action listener: _resource_record_pre_action 16:45:27 INFO - Running main action method: download_and_extract 16:45:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 16:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:27 INFO - https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/test_packages.json 16:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/test_packages.json 16:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 16:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 16:45:29 INFO - Downloaded 1302 bytes. 16:45:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 16:45:29 INFO - Using the following test package requirements: 16:45:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:45:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'jsshell-linux-x86_64.zip'], 16:45:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:45:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:45:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:45:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:45:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:45:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:29 INFO - https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:41 INFO - Downloaded 23192610 bytes. 16:45:41 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 16:45:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:41 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 16:45:43 INFO - Return code: 0 16:45:43 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 16:45:43 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')]} 16:45:43 INFO - https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:46 INFO - Downloaded 23192610 bytes. 16:45: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 16:45:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45: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 16:45:48 INFO - Return code: 0 16:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:48 INFO - https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:49 INFO - Downloaded 11132270 bytes. 16:45:49 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 16:45:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:49 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 16:45:50 INFO - Return code: 0 16:45:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:50 INFO - https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:45:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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 16:45:52 INFO - Downloaded 54895231 bytes. 16:45:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:52 INFO - mkdir: /builds/slave/test-pgo/properties 16:45:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 16:45:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 16:45:52 INFO - Contents: 16:45:52 INFO - build_url:https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:52 INFO - Running post-action listener: _resource_record_post_action 16:45:52 INFO - Running post-action listener: set_extra_try_arguments 16:45:52 INFO - ##### 16:45:52 INFO - ##### Running populate-webroot step. 16:45:52 INFO - ##### 16:45:52 INFO - Running pre-action listener: _resource_record_pre_action 16:45:52 INFO - Running main action method: populate_webroot 16:45:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:52 INFO - '--tppagecycles', 16:45:52 INFO - '7'], 16:45:52 INFO - 'tests': ['tsvgm']}}, 16:45:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:45:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:45:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:45:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'tests': ['damp', 'tps']}, 16:45:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['damp', 'tps']}, 16:45:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:45:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:52 INFO - 'other': {'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'other_l64': {'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'other_nol64': {'tests': ['a11yr', 16:45:52 INFO - 'ts_paint', 16:45:52 INFO - 'tpaint', 16:45:52 INFO - 'sessionrestore', 16:45:52 INFO - 'sessionrestore_no_auto_restore']}, 16:45:52 INFO - 'svgr': {'tests': ['tsvgx', 16:45:52 INFO - 'tsvgr_opacity', 16:45:52 INFO - 'tart', 16:45:52 INFO - 'tscrollx', 16:45:52 INFO - 'cart']}, 16:45:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['tsvgx', 16:45:52 INFO - 'tsvgr_opacity', 16:45:52 INFO - 'tart', 16:45:52 INFO - 'tscrollx', 16:45:52 INFO - 'cart']}, 16:45:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'tests': ['tp5o']}, 16:45:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'talos_options': ['--e10s'], 16:45:52 INFO - 'tests': ['tp5o']}, 16:45:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'talos_options': ['--xperf_path', 16:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:52 INFO - 'tests': ['tp5n']}, 16:45:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:52 INFO - 'talos_options': ['--e10s', 16:45:52 INFO - '--xperf_path', 16:45:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:52 INFO - 'tests': ['tp5n']}}, 16:45:52 INFO - 'talos.zip': {'path': '', 16:45:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:52 INFO - Running post-action listener: _resource_record_post_action 16:45:52 INFO - ##### 16:45:52 INFO - ##### Running create-virtualenv step. 16:45:52 INFO - ##### 16:45:52 INFO - Running pre-action listener: _resource_record_pre_action 16:45:52 INFO - Running main action method: create_virtualenv 16:45:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 16:45:52 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 16:45:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 16:45:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:52 INFO - Using real prefix '/usr' 16:45:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 16:45:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:55 INFO - Installing pip.................done. 16:45:55 INFO - Return code: 0 16:45:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:45:55 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 16:45:55 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 16:45:55 INFO - Using env: {'DISPLAY': ':0', 16:45:55 INFO - 'HOME': '/home/cltbld', 16:45:55 INFO - 'LANG': 'en_US.UTF-8', 16:45:55 INFO - 'LANGUAGE': 'en_US:en', 16:45:55 INFO - 'LOGNAME': 'cltbld', 16:45:55 INFO - 'MAIL': '/var/mail/cltbld', 16:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:55 INFO - 'MOZ_NO_REMOTE': '1', 16:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:55 INFO - 'NO_EM_RESTART': '1', 16:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:55 INFO - 'SHELL': '/bin/bash', 16:45:55 INFO - 'SHLVL': '1', 16:45:55 INFO - 'TERM': 'linux', 16:45:55 INFO - 'TMOUT': '86400', 16:45:55 INFO - 'USER': 'cltbld', 16:45:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:55 INFO - '_': '/tools/buildbot/bin/python'} 16:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:55 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 16:45:55 INFO - Cleaning up... 16:45:55 INFO - Return code: 0 16:45:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:45:55 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 16:45:55 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 16:45:55 INFO - Using env: {'DISPLAY': ':0', 16:45:55 INFO - 'HOME': '/home/cltbld', 16:45:55 INFO - 'LANG': 'en_US.UTF-8', 16:45:55 INFO - 'LANGUAGE': 'en_US:en', 16:45:55 INFO - 'LOGNAME': 'cltbld', 16:45:55 INFO - 'MAIL': '/var/mail/cltbld', 16:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:55 INFO - 'MOZ_NO_REMOTE': '1', 16:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:55 INFO - 'NO_EM_RESTART': '1', 16:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:55 INFO - 'SHELL': '/bin/bash', 16:45:55 INFO - 'SHLVL': '1', 16:45:55 INFO - 'TERM': 'linux', 16:45:55 INFO - 'TMOUT': '86400', 16:45:55 INFO - 'USER': 'cltbld', 16:45:55 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:55 INFO - '_': '/tools/buildbot/bin/python'} 16:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:55 INFO - Downloading/unpacking psutil>=0.7.1 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 16:45:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:45:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:57 INFO - Installing collected packages: psutil 16:45:57 INFO - Running setup.py install for psutil 16:45:57 INFO - building 'psutil._psutil_linux' extension 16:45:57 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 16:45:59 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 16:45:59 INFO - building 'psutil._psutil_posix' extension 16:45:59 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 16:45:59 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 16:45:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:59 INFO - Successfully installed psutil 16:45:59 INFO - Cleaning up... 16:45:59 INFO - Return code: 0 16:45:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 16:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:45:59 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 16:45:59 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 16:45:59 INFO - Using env: {'DISPLAY': ':0', 16:45:59 INFO - 'HOME': '/home/cltbld', 16:45:59 INFO - 'LANG': 'en_US.UTF-8', 16:45:59 INFO - 'LANGUAGE': 'en_US:en', 16:45:59 INFO - 'LOGNAME': 'cltbld', 16:45:59 INFO - 'MAIL': '/var/mail/cltbld', 16:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:59 INFO - 'MOZ_NO_REMOTE': '1', 16:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:59 INFO - 'NO_EM_RESTART': '1', 16:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 16:45:59 INFO - 'SHELL': '/bin/bash', 16:45:59 INFO - 'SHLVL': '1', 16:45:59 INFO - 'TERM': 'linux', 16:45:59 INFO - 'TMOUT': '86400', 16:45:59 INFO - 'USER': 'cltbld', 16:45:59 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:59 INFO - '_': '/tools/buildbot/bin/python'} 16:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:46:01 INFO - Installing collected packages: mozsystemmonitor 16:46:01 INFO - Running setup.py install for mozsystemmonitor 16:46:01 INFO - Successfully installed mozsystemmonitor 16:46:01 INFO - Cleaning up... 16:46:01 INFO - Return code: 0 16:46:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 16:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 16:46:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:46:01 INFO - Using env: {'DISPLAY': ':0', 16:46:01 INFO - 'HOME': '/home/cltbld', 16:46:01 INFO - 'LANG': 'en_US.UTF-8', 16:46:01 INFO - 'LANGUAGE': 'en_US:en', 16:46:01 INFO - 'LOGNAME': 'cltbld', 16:46:01 INFO - 'MAIL': '/var/mail/cltbld', 16:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:01 INFO - 'MOZ_NO_REMOTE': '1', 16:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:01 INFO - 'NO_EM_RESTART': '1', 16:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:01 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:01 INFO - 'SHELL': '/bin/bash', 16:46:01 INFO - 'SHLVL': '1', 16:46:01 INFO - 'TERM': 'linux', 16:46:01 INFO - 'TMOUT': '86400', 16:46:01 INFO - 'USER': 'cltbld', 16:46:01 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:01 INFO - '_': '/tools/buildbot/bin/python'} 16:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:46:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:46:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:46:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 16:46:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Downloading docopt-0.6.1.tar.gz 16:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 16:46:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:46:04 INFO - Running setup.py install for blobuploader 16:46:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:46:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 16:46:04 INFO - Running setup.py install for requests 16:46:05 INFO - Running setup.py install for docopt 16:46:05 INFO - Successfully installed blobuploader requests docopt 16:46:05 INFO - Cleaning up... 16:46:05 INFO - Return code: 0 16:46:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:05 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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46:05 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 16:46:05 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 16:46:05 INFO - Using env: {'DISPLAY': ':0', 16:46:05 INFO - 'HOME': '/home/cltbld', 16:46:05 INFO - 'LANG': 'en_US.UTF-8', 16:46:05 INFO - 'LANGUAGE': 'en_US:en', 16:46:05 INFO - 'LOGNAME': 'cltbld', 16:46:05 INFO - 'MAIL': '/var/mail/cltbld', 16:46:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:05 INFO - 'MOZ_NO_REMOTE': '1', 16:46:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:05 INFO - 'NO_EM_RESTART': '1', 16:46:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:05 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:05 INFO - 'SHELL': '/bin/bash', 16:46:05 INFO - 'SHLVL': '1', 16:46:05 INFO - 'TERM': 'linux', 16:46:05 INFO - 'TMOUT': '86400', 16:46:05 INFO - 'USER': 'cltbld', 16:46:05 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:05 INFO - '_': '/tools/buildbot/bin/python'} 16:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:46:05 INFO - Running setup.py (path:/tmp/pip-agBmRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:46:05 INFO - Running setup.py (path:/tmp/pip-ZIvcqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:46:05 INFO - Running setup.py (path:/tmp/pip-eZFqoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:46:05 INFO - Running setup.py (path:/tmp/pip-GjfcAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:46:05 INFO - Running setup.py (path:/tmp/pip-qMwVec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:46:05 INFO - Running setup.py (path:/tmp/pip-61RW69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:46:05 INFO - Running setup.py (path:/tmp/pip-SLKu_a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:46:05 INFO - Running setup.py (path:/tmp/pip-2ABOYV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:46:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:46:05 INFO - Running setup.py (path:/tmp/pip-jSgPqr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:46:06 INFO - Running setup.py (path:/tmp/pip-ladPO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:46:06 INFO - Running setup.py (path:/tmp/pip-mR72Kd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:46:06 INFO - Running setup.py (path:/tmp/pip-9nyKJK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:46:06 INFO - Running setup.py (path:/tmp/pip-4GElL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:46:06 INFO - Running setup.py (path:/tmp/pip-ii9rUL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:46:06 INFO - Running setup.py (path:/tmp/pip-8CZSl9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:46:06 INFO - Running setup.py (path:/tmp/pip-aFMofT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:46:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:46:06 INFO - Running setup.py (path:/tmp/pip-eRtpvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:46:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:46:06 INFO - Running setup.py install for manifestparser 16:46:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 16:46:06 INFO - Running setup.py install for mozcrash 16:46:06 INFO - Running setup.py install for mozdebug 16:46:06 INFO - Running setup.py install for mozdevice 16:46:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozfile 16:46:07 INFO - Running setup.py install for mozhttpd 16:46:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozinfo 16:46:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozInstall 16:46:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozleak 16:46:07 INFO - Running setup.py install for mozlog 16:46:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for moznetwork 16:46:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozprocess 16:46:07 INFO - Running setup.py install for mozprofile 16:46:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:46:07 INFO - Running setup.py install for mozrunner 16:46:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:46:08 INFO - Running setup.py install for mozscreenshot 16:46:08 INFO - Running setup.py install for moztest 16:46:08 INFO - Running setup.py install for mozversion 16:46:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:46:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:46:08 INFO - Cleaning up... 16:46:08 INFO - Return code: 0 16:46:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:46:08 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')]} 16:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:08 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')]} 16:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:08 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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46:08 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 16:46:08 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 16:46:08 INFO - Using env: {'DISPLAY': ':0', 16:46:08 INFO - 'HOME': '/home/cltbld', 16:46:08 INFO - 'LANG': 'en_US.UTF-8', 16:46:08 INFO - 'LANGUAGE': 'en_US:en', 16:46:08 INFO - 'LOGNAME': 'cltbld', 16:46:08 INFO - 'MAIL': '/var/mail/cltbld', 16:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:08 INFO - 'MOZ_NO_REMOTE': '1', 16:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:08 INFO - 'NO_EM_RESTART': '1', 16:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:08 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:08 INFO - 'SHELL': '/bin/bash', 16:46:08 INFO - 'SHLVL': '1', 16:46:08 INFO - 'TERM': 'linux', 16:46:08 INFO - 'TMOUT': '86400', 16:46:08 INFO - 'USER': 'cltbld', 16:46:08 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:08 INFO - '_': '/tools/buildbot/bin/python'} 16:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:46:08 INFO - Running setup.py (path:/tmp/pip-_O8wTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:46:08 INFO - Running setup.py (path:/tmp/pip-9T7MC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:46:08 INFO - Running setup.py (path:/tmp/pip-eLiYJy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:46:08 INFO - Running setup.py (path:/tmp/pip-h9__KO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:46:08 INFO - Running setup.py (path:/tmp/pip-1kFpVL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:46:08 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)) 16:46:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:46:08 INFO - Running setup.py (path:/tmp/pip-hBcs5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:46:09 INFO - Running setup.py (path:/tmp/pip-feYaMg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:46:09 INFO - Running setup.py (path:/tmp/pip-Ks8vQP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:46:09 INFO - Running setup.py (path:/tmp/pip-NFFkdg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:46:09 INFO - Running setup.py (path:/tmp/pip-pmwrF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:46:09 INFO - Running setup.py (path:/tmp/pip-IgMFcO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:46:09 INFO - Running setup.py (path:/tmp/pip-YQDybT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:46:09 INFO - Running setup.py (path:/tmp/pip-h5Qgrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:46:09 INFO - Running setup.py (path:/tmp/pip-49DOXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:46:09 INFO - Running setup.py (path:/tmp/pip-tpWllW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:46:09 INFO - Running setup.py (path:/tmp/pip-CXP4Sm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:46:09 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)) 16:46:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:46:09 INFO - Running setup.py (path:/tmp/pip-4igxAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 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)) 16:46:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:46:09 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 16:46:09 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 16:46:09 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 16:46:09 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 16:46:09 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 16:46:09 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 16:46:11 INFO - Downloading blessings-1.5.1.tar.gz 16:46:11 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 16:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:46:11 INFO - Installing collected packages: blessings 16:46:11 INFO - Running setup.py install for blessings 16:46:11 INFO - Successfully installed blessings 16:46:11 INFO - Cleaning up... 16:46:11 INFO - Return code: 0 16:46:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:46:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:46:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:46:11 INFO - Reading from file tmpfile_stdout 16:46:11 INFO - Current package versions: 16:46:11 INFO - argparse == 1.2.1 16:46:11 INFO - blessings == 1.5.1 16:46:11 INFO - blobuploader == 1.2.4 16:46:11 INFO - docopt == 0.6.1 16:46:11 INFO - manifestparser == 1.1 16:46:11 INFO - mozInstall == 1.12 16:46:11 INFO - mozcrash == 0.16 16:46:11 INFO - mozdebug == 0.1 16:46:11 INFO - mozdevice == 0.47 16:46:11 INFO - mozfile == 1.2 16:46:11 INFO - mozhttpd == 0.7 16:46:11 INFO - mozinfo == 0.9 16:46:11 INFO - mozleak == 0.1 16:46:11 INFO - mozlog == 3.1 16:46:11 INFO - moznetwork == 0.27 16:46:11 INFO - mozprocess == 0.22 16:46:11 INFO - mozprofile == 0.28 16:46:11 INFO - mozrunner == 6.11 16:46:11 INFO - mozscreenshot == 0.1 16:46:11 INFO - mozsystemmonitor == 0.0 16:46:11 INFO - moztest == 0.7 16:46:11 INFO - mozversion == 1.4 16:46:11 INFO - psutil == 3.1.1 16:46:11 INFO - requests == 1.2.3 16:46:11 INFO - wsgiref == 0.1.2 16:46:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:46:11 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')]} 16:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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', '-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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46:12 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 16:46:12 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 16:46:12 INFO - Using env: {'DISPLAY': ':0', 16:46:12 INFO - 'HOME': '/home/cltbld', 16:46:12 INFO - 'LANG': 'en_US.UTF-8', 16:46:12 INFO - 'LANGUAGE': 'en_US:en', 16:46:12 INFO - 'LOGNAME': 'cltbld', 16:46:12 INFO - 'MAIL': '/var/mail/cltbld', 16:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:12 INFO - 'MOZ_NO_REMOTE': '1', 16:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:12 INFO - 'NO_EM_RESTART': '1', 16:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:12 INFO - 'SHELL': '/bin/bash', 16:46:12 INFO - 'SHLVL': '1', 16:46:12 INFO - 'TERM': 'linux', 16:46:12 INFO - 'TMOUT': '86400', 16:46:12 INFO - 'USER': 'cltbld', 16:46:12 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:12 INFO - '_': '/tools/buildbot/bin/python'} 16:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 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)) 16:46:12 INFO - Cleaning up... 16:46:12 INFO - Return code: 0 16:46:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:46: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')]} 16:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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')]} 16:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46: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', 'jsonschema'] in /builds/slave/test-pgo/build 16:46: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 jsonschema 16:46:12 INFO - Using env: {'DISPLAY': ':0', 16:46:12 INFO - 'HOME': '/home/cltbld', 16:46:12 INFO - 'LANG': 'en_US.UTF-8', 16:46:12 INFO - 'LANGUAGE': 'en_US:en', 16:46:12 INFO - 'LOGNAME': 'cltbld', 16:46:12 INFO - 'MAIL': '/var/mail/cltbld', 16:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:12 INFO - 'MOZ_NO_REMOTE': '1', 16:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:12 INFO - 'NO_EM_RESTART': '1', 16:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:12 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:12 INFO - 'SHELL': '/bin/bash', 16:46:12 INFO - 'SHLVL': '1', 16:46:12 INFO - 'TERM': 'linux', 16:46:12 INFO - 'TMOUT': '86400', 16:46:12 INFO - 'USER': 'cltbld', 16:46:12 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:12 INFO - '_': '/tools/buildbot/bin/python'} 16:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:12 INFO - Downloading/unpacking jsonschema 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:46:14 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 16:46:14 INFO - Downloading/unpacking functools32 (from jsonschema) 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46:14 INFO - Downloading functools32-3.2.3-2.tar.gz 16:46:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:46:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:46:14 INFO - warning: no files found matching '*.txt' 16:46:14 INFO - no previously-included directories found matching 'build' 16:46:14 INFO - no previously-included directories found matching 'dist' 16:46:14 INFO - no previously-included directories found matching '.git*' 16:46:14 INFO - Installing collected packages: jsonschema, functools32 16:46:14 INFO - Running setup.py install for functools32 16:46:14 INFO - warning: no files found matching '*.txt' 16:46:14 INFO - no previously-included directories found matching 'build' 16:46:14 INFO - no previously-included directories found matching 'dist' 16:46:14 INFO - no previously-included directories found matching '.git*' 16:46:14 INFO - Successfully installed jsonschema functools32 16:46:14 INFO - Cleaning up... 16:46:14 INFO - Return code: 0 16:46:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:46:14 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')]} 16:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:14 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')]} 16:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:14 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 0x7f01bba8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f59630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, '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': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', '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 16:46:14 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 16:46:14 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 16:46:14 INFO - Using env: {'DISPLAY': ':0', 16:46:14 INFO - 'HOME': '/home/cltbld', 16:46:14 INFO - 'LANG': 'en_US.UTF-8', 16:46:14 INFO - 'LANGUAGE': 'en_US:en', 16:46:14 INFO - 'LOGNAME': 'cltbld', 16:46:14 INFO - 'MAIL': '/var/mail/cltbld', 16:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:14 INFO - 'MOZ_NO_REMOTE': '1', 16:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:14 INFO - 'NO_EM_RESTART': '1', 16:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:14 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:14 INFO - 'SHELL': '/bin/bash', 16:46:14 INFO - 'SHLVL': '1', 16:46:14 INFO - 'TERM': 'linux', 16:46:14 INFO - 'TMOUT': '86400', 16:46:14 INFO - 'USER': 'cltbld', 16:46:14 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:14 INFO - '_': '/tools/buildbot/bin/python'} 16:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:14 INFO - Downloading/unpacking flake8 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46: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 16:46:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:46:16 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 16:46:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:46:16 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 16:46:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:16 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 16:46:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:46:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:46:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:46:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:46:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:46:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:46:17 INFO - no previously-included directories found matching 'docs/_build' 16:46:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:46:17 INFO - Running setup.py install for pep8 16:46:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:46:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:46:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:46:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:46:17 INFO - no previously-included directories found matching 'docs/_build' 16:46:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:46:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:46:17 INFO - Cleaning up... 16:46:17 INFO - Return code: 0 16:46:17 INFO - Running post-action listener: _resource_record_post_action 16:46:17 INFO - Running post-action listener: _start_resource_monitoring 16:46:17 INFO - Starting resource monitoring. 16:46:17 INFO - ##### 16:46:17 INFO - ##### Running install step. 16:46:17 INFO - ##### 16:46:17 INFO - Running pre-action listener: _resource_record_pre_action 16:46:17 INFO - Running main action method: install 16:46:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:46:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:46:17 INFO - Reading from file tmpfile_stdout 16:46:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:46:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:46:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:46:17 INFO - Reading from file tmpfile_stdout 16:46:17 INFO - Output received: 16:46:17 INFO - Usage: mozinstall [options] installer 16:46:17 INFO - Options: 16:46:17 INFO - -h, --help show this help message and exit 16:46:17 INFO - -d DEST, --destination=DEST 16:46:17 INFO - Directory to install application into. [default: 16:46:17 INFO - "/builds/slave/test-pgo"] 16:46:17 INFO - --app=APP Application being installed. [default: firefox] 16:46:17 INFO - mkdir: /builds/slave/test-pgo/build/application 16:46:17 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'] 16:46:17 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 16:46:33 INFO - Reading from file tmpfile_stdout 16:46:33 INFO - Output received: 16:46:33 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:46:33 INFO - Running post-action listener: _resource_record_post_action 16:46:33 INFO - ##### 16:46:33 INFO - ##### Running run-tests step. 16:46:33 INFO - ##### 16:46:33 INFO - Running pre-action listener: _resource_record_pre_action 16:46:33 INFO - Running main action method: run_tests 16:46:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:46:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:46:33 INFO - Python 2.7.3 16:46:33 INFO - Return code: 0 16:46:33 INFO - grabbing minidump binary from tooltool 16:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:33 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 0x1fea840>, '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 0x1f576b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f57b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:46:33 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 16:46:33 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 16:46:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:33 INFO - Return code: 0 16:46:33 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:46:33 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:46:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:46:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:46:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:46:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:46:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:46:34 INFO - Return code: 0 16:46:34 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/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:46:34 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/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 16:46:34 INFO - Using env: {'DISPLAY': ':0', 16:46:34 INFO - 'HOME': '/home/cltbld', 16:46:34 INFO - 'LANG': 'en_US.UTF-8', 16:46:34 INFO - 'LANGUAGE': 'en_US:en', 16:46:34 INFO - 'LOGNAME': 'cltbld', 16:46:34 INFO - 'MAIL': '/var/mail/cltbld', 16:46:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:46:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:34 INFO - 'MOZ_NO_REMOTE': '1', 16:46:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:34 INFO - 'NO_EM_RESTART': '1', 16:46:34 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:46:34 INFO - 'PWD': '/builds/slave/test-pgo', 16:46:34 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:46:34 INFO - 'SHELL': '/bin/bash', 16:46:34 INFO - 'SHLVL': '1', 16:46:34 INFO - 'TERM': 'linux', 16:46:34 INFO - 'TMOUT': '86400', 16:46:34 INFO - 'USER': 'cltbld', 16:46:34 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402', 16:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:34 INFO - '_': '/tools/buildbot/bin/python'} 16:46:34 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/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:46:34 INFO - mozversion application_buildid: 20151229143006 16:46:34 INFO - mozversion application_changeset: ab22ba41b8fce8eaf15ed4128f6c978b20b8b238 16:46:34 INFO - mozversion application_display_name: Nightly 16:46:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:34 INFO - mozversion application_name: Firefox 16:46:34 INFO - mozversion application_remotingname: firefox 16:46:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:46:34 INFO - mozversion application_vendor: Mozilla 16:46:34 INFO - mozversion application_version: 46.0a1 16:46:34 INFO - mozversion platform_buildid: 20151229143006 16:46:34 INFO - mozversion platform_changeset: ab22ba41b8fce8eaf15ed4128f6c978b20b8b238 16:46:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:46:34 INFO - mozversion platform_version: 46.0a1 16:46:34 INFO - using testdate: 1451436394 16:46:34 INFO - actual date: 1451436394 16:46:35 INFO - starting webserver on 'localhost:41718' 16:46:35 INFO - SUITE-START | Running 3 tests 16:46:35 INFO - TEST-START | dromaeo_css 16:46:35 INFO - operating with platform_type : linux_ 16:46:35 INFO - Initialising browser for dromaeo_css test... 16:46:35 INFO - TEST-INFO | started process 3348 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt_uhUH/profile http://localhost:41718/getInfo.html) 16:46:41 INFO - PROCESS | 3348 | __metrics Screen width/height:1600/1200 16:46:41 INFO - PROCESS | 3348 | colorDepth:24 16:46:41 INFO - PROCESS | 3348 | Browser inner width/height: 1024/697 16:46:41 INFO - PROCESS | 3348 | __metrics 16:46:41 INFO - PROCESS | 3348 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:46:42 INFO - TEST-INFO | 3348: exit 0 16:46:42 INFO - Browser initialized. 16:46:42 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:42 INFO - TEST-INFO | started process 3479 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpt_uhUH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:54 INFO - PROCESS | 3479 | RSS: Main: 149721088 16:46:54 INFO - PROCESS | 3479 | 16:47:44 INFO - PROCESS | 3479 | 1451436464064 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] 16:49:52 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41718/tests/dromaeo/cssquery-ext.html) 16:49:53 INFO - PROCESS | 3479 | RSS: Main: 157745152 16:49:53 INFO - PROCESS | 3479 | 16:52:55 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-ext.html (next: http://localhost:41718/tests/dromaeo/cssquery-jquery.html) 16:52:56 INFO - PROCESS | 3479 | RSS: Main: 152309760 16:52:56 INFO - PROCESS | 3479 | 16:55:58 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41718/tests/dromaeo/cssquery-mootools.html) 16:55:58 INFO - PROCESS | 3479 | RSS: Main: 153296896 16:55:58 INFO - PROCESS | 3479 | 16:59:00 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41718/tests/dromaeo/cssquery-prototype.html) 16:59:00 INFO - PROCESS | 3479 | RSS: Main: 152678400 16:59:00 INFO - PROCESS | 3479 | 17:02:03 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41718/tests/dromaeo/cssquery-yui.html) 17:02:03 INFO - PROCESS | 3479 | RSS: Main: 152907776 17:02:03 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | Cycle 1(1): loaded http://localhost:41718/tests/dromaeo/cssquery-yui.html (next: http://localhost:41718/tests/dromaeo/cssquery-dojo.html) 17:05:06 INFO - PROCESS | 3479 | RSS: Main: 154963968 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | __start_tp_report 17:05:06 INFO - PROCESS | 3479 | _x_x_mozilla_page_load 17:05:06 INFO - PROCESS | 3479 | _x_x_mozilla_page_load_details 17:05:06 INFO - PROCESS | 3479 | |i|pagename|runs| 17:05:06 INFO - PROCESS | 3479 | |0;dojo.html;3105.829179395133;3147.449196390631;3178.221335772736;3201.7278531324837;3216.774825762196;5103.821366252182;5179.093658609742;5184.9222261666055;5186.299849520314;5268.236105764662;5140.7172605506685;5174;5200.765965531551;5225.451327610594;5238.26664267002;4748.358971538842;4764;4785.258284965836;4793.18515852306;4862.17343051682;4515.345274935133;4772.761361931907;4786.994731106472;4838.322634831126;4849.660523763338;4652.604528615072;4661.300804879262;4731.148393289223;4748.121597504472;4754.144254034272;4791.616670666338;4798.5441383068555;4798.736069516175;4808.951910480885;4833.371661683958;4569.2689169732685;4738.407699037621;4757.762111894392;4776.785044672998;4817.590504807095;4932.432770231433;4962.9007419851405;4990.326305948687;5024.824131155428;5026.396832380138;5574.303212098488;5581.190727344512;5582.720863956786;5602.551795856321;5650.74571644277;5533.916991245134;5630.746616402272;5633.239512665778;5635.492805647511;5637.3235211774845;5212.478752124795;5259.211118332242;5269.446708095633;5279.340082489689;5330.840074797762;5687.289088863892;5690.2033715279895;5691.089425691869;5702.0591602385975;5715.085586306171;5307.787688492494;5442.455754424605;5485.945140548623;5532.972335138298;5560.972195138998;5596.944030559643;5599.776008959596;5603.411641777555;5632.324121105494;5649.180868774005;5542.473465020817;5579.637323573955;5607.579431542651;5609.859753506195;5615.354234263112;5505.394406615269;5546.473085056913;5559.082751346064;5609.607327487119;5642.125470552071;4345.608895199447;4349.369341445473;4358.21552120615;4366.868993930188;4384.0355121873135;3900.863469778544;3919.451276821247;3930.8231129599235;3961.1285517186175;4006.4390985262085;5151.562117220078;5241.868953276198;5254.395744489356;5299.894002119936;5321.042212401805;5574.108142697149;5586.776528938878;5603.663780173202;5611;5652.406497317805;5195.402528709247;5267.394249661262;5268.446813084571;5269.604779641542;5308.893822123536;4790.209615413488;4823.27650852368;4853.587445067209;4869.853904382874;4879.902401951941;5777.884442311214;5778.422157784272;5783.479486846204;5785.074388097968;5791.594588378773;5470.452954704498;5605.32736071674;5607.859803504945;5616.85957851057;5649.20911072442;5614.354349249726;5806.767729290781;5855.853603659943;5864.648121112747;5887.764489420375;5613.88772224545;5618.550515958632;5621.747021383966;5625.634333768292;5643.125315576092;5537.889242215214;5628.437156284339;5639.943600563942;5708.257926469699;5712.571557133148;5443.510084092451;5461.0716178248995;5473.890522189614;5475.6440831345835;5525.475079867406;5428.4842939920645;5484.341878974548;5520.171974203901;5521.585881059017;5526.972365138309;5163.0706472833745;5256.710880901587;5336.813211537577;5356.196570514454;5380.300560927054;5535.086710692691;5571.526420254324;5576.219329293983;5583.553315734813;5591.720413979204;5365.034293827149;5365.785368585369;5369.865753356041;5376.0591896418755;5478.835634930959 17:05:06 INFO - PROCESS | 3479 | |1;ext.html;505.2673623246294;567.8586042055467;573.936866944636;579.0503574138411;581.1079992211953;26145;35066.649333506655;35563.82218088906;35656.82171589145;35690.821545892264;38484.42273365902;38889.61110388895;38943.221135577274;38982;39012.21975560487;8390.286825619829;8522.74431767048;8540.78648033801;8555.914440855606;8565.614547345385;8245.299149572293;8351.665933362658;8374.120717324684;8380.287675547555;8420.747377578682;8371;8434.114417986115;8446.535440550768;8457.57712114395;8485.575721213945;8057.435979481439;8190.713325033625;8191.221833925797;8196.631151598192;8235.464694794879;8228.670853165866;8305.086440491541;8369.49783013015;8371.83256334876;8533.701320453816;38305.808470957745;38843.8057809712;39047;39259.41110883339;39309.80345098285;3107.1765982014786;3152.7477801775804;3449.9243088200083;3478.617352091268;3791.3613174263014;28695.713042869513;28732.281692957633;28926;29472.115836524725;29964.101076967727;3875.2830726315724;3935.232629637222;3986.760794352319;3990.8004599770184;4016.402373193607;262857;263914.9999999981;264770;265010;265508;38899.80550097288;55198.17202741962;55396.16905746417;55481.89036219253;55570.72214638901;49493;59694.70152649209;60205.69897150486;60919.6954015236;61006.69496652488;14795.704085918222;14917.104973701613;14993.700125997419;15027.699446011018;15072;11377.089832813355;11413.600523981788;11433.599824006285;11557.479913403917;11568.710782230342;17929.462116136536;17975.191116399794;17996.190171442056;18021;18735.531611709543;7329.853402931912;7563.9621801890635;7579.962100189464;7585.62071896403;7653.540787552764;992.8858181309242;1019.0726438940677;1035.4512108582312;1081.8214994525972;1133.9659810205708;28616;28764;29275;29596.55605165924;31198.68801312003;1040.9843852342221;1049.8477720730452;1053.873535175784;1059.2426415113232;1140.1278022312938;14219.573412797426;14235.359408826627;14243.359048842827;14440.85559144416;14532;318749;320741;321967;322437;322544;49519.75240123776;50029.49970500321;50085.49914500881;50097.74951125221;50174.74912625414;1331.3942156318851;1343.621789432718;1347.730453909222;1348;1351.4999450203488;26660.200193994213;27333.589996150473;27433.31416714598;27790.86104569464;28010.85994570014;44753.77623111864;44782;44785.32822007607;45141;45183.09633807371;296852;297689;297808;299008;299281;29807.70192298136;31280.843595781877;31708.365832683678;31767.682323176472;32007.679923201402;37023.44464832976;37545.62454375421;37644;37878.43182352322;38521.807390963986;33810.37835351969;34690.82654586711;34793.13017174591;34932.82533587316;35134.64865351314;33940.49089263712;34732.47901281432;35365.64634353624;35385.46921796124;35490.8225458871;33429.33141337111;34007.82996085004;34456.65543344635;34588.654113459546;34622.13444663904;29108.7089129106;30316.84841575778;31616.209594760316;31746;31825.5226171603;24232.515349692556;24464.388390290384;24729.752702472746;24990.500189995735;25019 17:05:06 INFO - PROCESS | 3479 | |2;jquery.html;349.55082718706467;352.2532231668862;355.147645650439;356.74136251217857;358.0654491776463;11441.59954401596;11916.880831191686;16228.10745409002;17368.73946890796;18839.623207535842;17354.305827766875;17524.474265772016;17614.91192544039;17917.193726282316;17936.282548698036;6010.939890601093;6153.476954458876;6206.975848984912;6209.192804935352;6209.565330426872;4902.828401005965;6125.234345706786;6202.658853763064;6205.131281620576;6215.906761398583;6177.876442471148;6193.473554747852;6201.379862013785;6204.224471941007;6223.875522489548;6083.878322433548;6167.506599472032;6197.597156184834;6209.161763161983;6218.751249949996;5968.403159683997;5968.940310596882;5985.9401405986255;5994.8501287467725;5997;17601.295948162056;22245.555088898294;22352.10591576335;22471.101155953744;23422.765772342227;2243.4839986803127;2297.9540409191723;2375.121205154087;2403.6875206223253;2460.8031357491536;14315.144156606651;14437.133771973715;14507.854921450757;14519.854801452062;14867.256637168099;1986.701994700792;2001.1595130045416;2017.0775252010346;2022.5247066939257;2092.4350425385214;65901.52565880712;68888.65555672189;70259.29740702579;71569.28430715678;71950.28049719488;15118.697626047637;15494.612634684223;15567.377304907677;15613.453529126426;15637.765433518507;12467.87532124667;12932.612021639367;12961.481540738454;24786.5042699145;24815.751842481706;7343.48595598303;7457.627118644046;7596.696132154762;7601.163871974079;7630.8855367169535;7486.326230639269;7495.400367970549;7497.587632680146;7527.096748390229;7575.393968482508;4359.716618419792;4383.693141480129;4392.912141757147;4406.250937340596;4407.911841763147;1819.145001849129;1849.5653521422455;1870.9251629934922;1901.1254822781398;1918.3189967561316;914.131575003749;928.7724507495707;939.3096074385321;993.5280741647804;1011.3931641015332;16486.258118384703;16614.620227275034;16825.2428640709;16829.32682692703;17116.14419279031;828.8768718386499;886.4592598514901;921.235374639048;930.4789317981952;1026.1790567546082;6075.878482430327;6312.116303717483;6319.210098737658;6398.712057957403;6404.871902561923;418257;512605;522638;529167;529729;82786.58606706928;83607;84042.99999999878;84240;84722;493.9382577177853;494.7452062187976;497.1920628977911;500.7246014691905;501.1980830670897;10889.346639201673;10921.327894471458;10981.945090274497;11091.279066860629;11159.888401115884;31904;34485;34576.654233457346;36323.45514817333;36698.44952325664;40080.79959600183;41972.79013604912;43361;43606.34590481082;44234;9551.570179341807;9668.56491457872;9906.653267135904;9921.751956201153;9933.453660048766;11422.428878555873;11493.252938558968;14930.402783888523;17820.55448613795;18395.356162534248;13961.720765584834;14073.718525629225;14621.0496317739;15099.094054356774;15255.160966146968;14251.429942802586;14361.066530675473;14536.273186340852;14791.92604036973;14973.870028323761;15130.243487825785;15354.385824567338;15355.539333820003;15672.216389180723;15714.371425142866;9691.12779849817;9824.950875245579;9913.405195688281;9955.402675839472;10045.94517575644;12512.812307815571;14919.477818276308;15162.696746064796;15186.24068796578;15273.465428709942 17:05:06 INFO - PROCESS | 3479 | |3;mootools.html;1390.6384340071581;1408.957731268062;1522.566068670429;1691.8139004709487;1697.2447260968866;5729.914051289234;5740;6490.513211509138;6612.6693665316725;6613;6414.326495717953;6437.903431448532;6543.47652187825;6552.148220731298;6564.081028655992;2059.0631262775437;2072.9274475393363;2088.592724418739;2089.676100204471;2094.9057292421803;2068.9689654655194;2105.1789801977243;2116.87298762074;2120.268507364957;2124.076026928291;2081.583683263346;2095.0467537270583;2113.682947557871;2119.745630524339;2126.2345555599973;2098.821600163988;2102.432343267317;2104.5264815416563;2122.61792877282;2124.6600543913055;2049.28275103714;2061.7319748432756;2113.1652997066226;2115.058798834519;2116.312198535467;6649.202095748541;6670.3329667033395;6747.730090796412;6752.426043786284;6753.797386078426;4119.258533463975;4147.709660323779;4149.024979129902;4168.895777605584;4185.97907010466;2774.597683335925;2796.874140663675;2844.502212112872;2858.814177078483;2862.4990626640256;920.8848893888264;963.6145541783272;966.1546147121269;986.3736527305141;988.2439933450844;8831.161039701283;8844.646214151426;8863.069377715376;8870;8884.378093533454;3778.1688028633657;3826.4260360945523;3894.7857867817543;3897.8830635080994;3901.219756048745;7765.961170194113;7782.221777822286;7796.961015194887;7853.136155022943;7873.842523149505;4196.790160492024;4257.297545904891;4260.275753121977;4268.765217912983;4268.807903644343;3810.0855794609092;3860.8455661773214;3868.516435445569;3879.049632839972;3881.84472621092;3247.0745837436216;3253.2192273854102;3288.753343499199;3300.818454984999;3307.4046671598862;1000.3247807729754;1001.399160503692;1003.8996100389902;1007.2345017786535;1007.6674697349857;1023.4268809466722;1077.849101125843;1235.6416639174718;1251.9374031298398;1281.6795801049739;6248.094026366151;6253.812385628438;6300.3699630037545;6303.9684801575695;6312.810615681537;617.6788070203559;637.4072112935015;640.8494003909078;642.8746394453037;776.157868712442;5041.773120209599;5241.475852414805;5251.317328747238;5251.76367063483;5262.789488420421;7904.4071694623135;8017.717165253648;8096.230858068474;8151.918480815116;8176.918230817735;8009.679612815538;8065.556394398364;8068.677252909818;8093.676252949816;8108.189181081844;6372.490200783926;6396.42432181106;6433.806985790434;6460.3862633049785;6463.450606698483;6054.243219597551;6231.189945307081;6234.812955611339;6235.282942461675;6240.781572644935;7128.786136415916;7130.251323610946;7157.355837974607;7278.381337586365;7342.5227360221415;7216.458765592497;7274.96362518184;7287;7288.380487658608;7340.779776606711;5758.740856661377;5767.365589785204;5825.300963884361;5827.912581311199;5912.113183022581;6436.452901503425;6441.935580644134;6448.709808058555;6453.9354606453335;6481.643509607017;5987.126179433983;6190.0405437157315;6203.286622038523;6266.467350275278;6288.465480434214;5929.169916211647;5942.494887934574;6015.969920150371;6044.33512313654;6094.451499365078;6204.255489341308;6205.844853878509;6297.338779428277;6339.049142628643;6366.140571023038;5641.887162256814;5733.254676891977;5752.424757524382;5771.884562308646;5806.361300257053;5597;5610.410906854721;5792.247007888947;5879.911801323069;5896.056630939029 17:05:06 INFO - PROCESS | 3479 | |4;prototype.html;327.44498075761595;327.4940217364172;330.81639689972064;335.35109562995603;337.91889946412863;6236.625802451845;6324.114623952644;6330.683465826707;6357.300696923335;6378;6134.417230363119;6310.368963103688;6321.367863213688;6333.050042493628;6345.143405640237;4814.253790662436;4830.082284365977;4839.153148199069;4850.636202284834;4852.053849499349;4843.515648435164;4852.49048849871;4857.149998750222;4859.854204373874;4863.659543831933;4701.576858082772;4753.714777113367;4757.3815403997605;4759.833405830796;4784.712917224961;4765.475797662254;4773.737444440554;4786.545278198566;4789.544993225638;4789.664723469358;4181.289180839264;4187.2044311581;4194.161167766459;4200.726952748092;4210.705250632457;5962.165296858443;5990.490808281302;5998.040313549811;6020.1872747179;6021.6989150542295;5525.557955363562;5633.211350410946;5642.153676948449;5655.236543066716;5664.235328230719;6691.955160402054;6702.028205910165;6718.764843230463;6720.764773232962;6724.83187920301;4677.204875171195;4700.29495575663;4700.811967521295;4702.741349225791;4704.506026867198;6743.089682892844;6938.722451102;6941.930580694179;6983.2318444971015;7032.542884712478;4702.6708130431225;4735.337052812609;4737.502562230985;4751.83368582098;4755.785989630475;4764.404449443819;4801.063792560487;4817;4823.493533179036;4832.589229915497;5556.611037227436;5570.526505247019;5577.553795696334;5634.661920284796;5653.830385088454;6569.638669873203;6807.21717002551;6828.829279268058;6838.658067096625;6853.554518956252;1706.2663054886518;1710.0765586583107;1749.0817320906372;1749.5101371615967;1751.6496700659918;1113.0372228022864;1133.5635780224673;1156.8900954409319;1163.6858048326903;1174.4714878304796;6152.107944348134;6180.845478863064;6186.938130618726;6199.411055949678;6208.534359923024;6718.529702920847;6733.225679046875;6740;6752.08846805675;6753.932460675429;6044.455998960115;6187.566870319034;6189.226346706661;6192.535559832941;6220.688965551704;3730.123420996064;3746.9437958430644;3747.8500859965843;3758.379867321861;3763.247350529905;7108.5024048317155;7122.786316410516;7131.286871312827;7143.821404464826;7147.178074521393;6863.210730765926;6976.651167441608;6991.091158149408;6991.19601245853;7006.509544331848;7103.644817759091;7107.253738357502;7128.6435678215885;7133.785986420416;7136.143662760398;6806.081179040766;6825.146856642919;6857.931420685729;6858.828529286808;6859.691313890987;6708.496862735412;6796.830079248059;6826.112605361272;6827.453803695593;6904.827379315558;7208.06295181623;7376.520526165782;7381.446391520765;7388.815279618053;7388.889166662397;4675.76621168947;4718.929216061831;4730.385049943486;4737.194676905004;4738.810447582196;6844.8973265402055;6973.546719463218;7000.124984376953;7010.088688470466;7053.0478385419365;6825.89761153593;6826.453883689393;6831.555948863308;6841.21326047491;6856.314368563104;6809.557378770364;6823.112995310578;6829.453643708392;6830.93169068303;6852.417544508772;6448.742050317935;6495.025746138117;6531.085648009377;6559.672016399257;6581.111549940697;6829.146356705412;6837.726490940307;6846.315368463114;6849.31506849331;6853.348931851466;6636.734530618721;6670.332966703291;6692.966535167293;6702.597844129368;6708.798736037927 17:05:06 INFO - PROCESS | 3479 | |5;yui.html;742.2317900972492;801.8997625296835;823.7117009046831;827.3381294964029;828.6229765456718;12698.238105713652;12859.742805143891;12882.4202910869;12923.224606523616;12929.418176182082;11827.881721182786;11998.580049698263;11999.760004799899;12035.75928481432;12693.705567537338;795.3835777272617;805.0379796143611;809.2393150438598;809.6235250608465;809.7894547417654;806.1092492795465;806.7660378490231;809.76112046946;813.1055838577547;815.4699445360504;835.4319063037133;838.932885369172;838.9538575378351;840.0549381945311;842.0737189092011;825.7357645553425;833.6498670558381;833.8749187621845;834.3492076180589;837.4975014990987;608.7625825927892;610.6885488400903;611.0711718188373;612.7150874843219;613.2702084519408;13361.398737056856;13466.797998030037;13540;13560.254186019765;13560.864391356157;11699.23954942926;12189.634310970685;12372.505099795997;12533.498660053587;12610.243385396814;10223.744406389826;10423.270371074028;10503.369797812156;10557.208209384251;10698.625548105856;3575.8212089395424;3613.602503724588;3633.909152271188;3668.211334563055;3756.098536351283;42275.36586951198;42724.359134613005;42772.78613606943;42816.357754633704;42832.143357132685;9399.342046056847;9812.411255324703;9829.80340393188;9901.306908516335;9998.500074996222;16932.32270709158;16978;16980.575485612957;16990.57523561921;17007;7157.57054576727;7302.6713797878165;7331.450141239428;7430.405567554582;7494.887576686354;4131.607497287753;4222.218889505451;4259.488861336659;4321.65426765858;4338.349247612883;2996.535536991726;3001.6097907271915;3011.036468330113;3017.6982301770086;3024.6672865984724;527.4251066337711;549.3572520151353;551.4760977071718;567.4042255631571;567.5544697412594;439.45068664169787;461.9491855895849;476.3807050833902;489.43714728062304;506.6959824105581;7216.242294559101;7224.855502889913;7325.377342925804;7377.6311184440565;7385.852282954311;488.4870885570137;488.9168841296988;516.8242797448886;518.2304278146948;555.4140381897057;3247.399231142246;3264.5756051713124;3527.1182204448887;3551.5560554930635;3593.1196856770257;54969.45030549723;55344.446555534734;55422.72288638531;55453;58629.70685146547;48028;48823.26765098526;49019;49039;49839;45580.54419455763;45730.77134614372;45746.31380529295;46589.30116048194;46840;6784.321567843176;6797.898031529432;6895.5173137879865;6976.860462790817;6982.581045137308;32694.509582355808;33513.49729754104;34482;34761;36212.27575448529;41097.58902411057;42378.36432453454;42600.360994585724;43844.34233486436;43934.56065439305;9885.703428897144;9895.25785566071;10050.798984020132;10394;10487.790244195226;10692.251542391958;11432.599859004895;11595.072394208612;11832.645020649394;12116.636500904988;8702.303815694855;9223.123803238681;9998.700038998843;10099;10530.57877684884;9075;9247.213986811197;9428;9444.48055356962;9557.092076252746;9841.753956151153;9956.352837065568;9996.800063998533;10020.64927727526;10182.643607473703;8141.51150930946;8254.628541715518;8547.487150770974;8636.352273579381;8645.524496152771;8111;8136.389770767098;8162.306203972729;8241.50550966944;8255.133211012757 17:05:06 INFO - PROCESS | 3479 | __end_tp_report 17:05:06 INFO - PROCESS | 3479 | __start_cc_report 17:05:06 INFO - PROCESS | 3479 | _x_x_mozilla_cycle_collect,306 17:05:06 INFO - PROCESS | 3479 | __end_cc_report 17:05:06 INFO - PROCESS | 3479 | __startTimestamp1451437506460__endTimestamp 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | ------- Summary: start ------- 17:05:06 INFO - PROCESS | 3479 | Number of tests: 6 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#0] dojo.html Cycles:165 Average:5203.22 Median:5369.87 stddev:566.29 (10.5%) stddev-sans-first:543.60 17:05:06 INFO - PROCESS | 3479 | Values: 3105.8 3147.4 3178.2 3201.7 3216.8 5103.8 5179.1 5184.9 5186.3 5268.2 5140.7 5174.0 5200.8 5225.5 5238.3 4748.4 4764.0 4785.3 4793.2 4862.2 4515.3 4772.8 4787.0 4838.3 4849.7 4652.6 4661.3 4731.1 4748.1 4754.1 4791.6 4798.5 4798.7 4809.0 4833.4 4569.3 4738.4 4757.8 4776.8 4817.6 4932.4 4962.9 4990.3 5024.8 5026.4 5574.3 5581.2 5582.7 5602.6 5650.7 5533.9 5630.7 5633.2 5635.5 5637.3 5212.5 5259.2 5269.4 5279.3 5330.8 5687.3 5690.2 5691.1 5702.1 5715.1 5307.8 5442.5 5485.9 5533.0 5561.0 5596.9 5599.8 5603.4 5632.3 5649.2 5542.5 5579.6 5607.6 5609.9 5615.4 5505.4 5546.5 5559.1 5609.6 5642.1 4345.6 4349.4 4358.2 4366.9 4384.0 3900.9 3919.5 3930.8 3961.1 4006.4 5151.6 5241.9 5254.4 5299.9 5321.0 5574.1 5586.8 5603.7 5611.0 5652.4 5195.4 5267.4 5268.4 5269.6 5308.9 4790.2 4823.3 4853.6 4869.9 4879.9 5777.9 5778.4 5783.5 5785.1 5791.6 5470.5 5605.3 5607.9 5616.9 5649.2 5614.4 5806.8 5855.9 5864.6 5887.8 5613.9 5618.6 5621.7 5625.6 5643.1 5537.9 5628.4 5639.9 5708.3 5712.6 5443.5 5461.1 5473.9 5475.6 5525.5 5428.5 5484.3 5520.2 5521.6 5527.0 5163.1 5256.7 5336.8 5356.2 5380.3 5535.1 5571.5 5576.2 5583.6 5591.7 5365.0 5365.8 5369.9 5376.1 5478.8 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#1] ext.html Cycles:180 Average:45412.13 Median:34711.65 stddev:77318.26 (222.7%) stddev-sans-first:77461.64 17:05:06 INFO - PROCESS | 3479 | Values: 505.3 567.9 573.9 579.1 581.1 26145.0 35066.6 35563.8 35656.8 35690.8 38484.4 38889.6 38943.2 38982.0 39012.2 8390.3 8522.7 8540.8 8555.9 8565.6 8245.3 8351.7 8374.1 8380.3 8420.7 8371.0 8434.1 8446.5 8457.6 8485.6 8057.4 8190.7 8191.2 8196.6 8235.5 8228.7 8305.1 8369.5 8371.8 8533.7 38305.8 38843.8 39047.0 39259.4 39309.8 3107.2 3152.7 3449.9 3478.6 3791.4 28695.7 28732.3 28926.0 29472.1 29964.1 3875.3 3935.2 3986.8 3990.8 4016.4 262857.0 263915.0 264770.0 265010.0 265508.0 38899.8 55198.2 55396.2 55481.9 55570.7 49493.0 59694.7 60205.7 60919.7 61006.7 14795.7 14917.1 14993.7 15027.7 15072.0 11377.1 11413.6 11433.6 11557.5 11568.7 17929.5 17975.2 17996.2 18021.0 18735.5 7329.9 7564.0 7580.0 7585.6 7653.5 992.9 1019.1 1035.5 1081.8 1134.0 28616.0 28764.0 29275.0 29596.6 31198.7 1041.0 1049.8 1053.9 1059.2 1140.1 14219.6 14235.4 14243.4 14440.9 14532.0 318749.0 320741.0 321967.0 322437.0 322544.0 49519.8 50029.5 50085.5 50097.7 50174.7 1331.4 1343.6 1347.7 1348.0 1351.5 26660.2 27333.6 27433.3 27790.9 28010.9 44753.8 44782.0 44785.3 45141.0 45183.1 296852.0 297689.0 297808.0 299008.0 299281.0 29807.7 31280.8 31708.4 31767.7 32007.7 37023.4 37545.6 37644.0 37878.4 38521.8 33810.4 34690.8 34793.1 34932.8 35134.6 33940.5 34732.5 35365.6 35385.5 35490.8 33429.3 34007.8 34456.7 34588.7 34622.1 29108.7 30316.8 31616.2 31746.0 31825.5 24232.5 24464.4 24729.8 24990.5 25019.0 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#2] jquery.html Cycles:180 Average:28396.05 Median:18340.76 stddev:82573.76 (450.2%) stddev-sans-first:82778.55 17:05:06 INFO - PROCESS | 3479 | Values: 349.6 352.3 355.1 356.7 358.1 11441.6 11916.9 16228.1 17368.7 18839.6 17354.3 17524.5 17614.9 17917.2 17936.3 6010.9 6153.5 6207.0 6209.2 6209.6 4902.8 6125.2 6202.7 6205.1 6215.9 6177.9 6193.5 6201.4 6204.2 6223.9 6083.9 6167.5 6197.6 6209.2 6218.8 5968.4 5968.9 5985.9 5994.9 5997.0 17601.3 22245.6 22352.1 22471.1 23422.8 2243.5 2298.0 2375.1 2403.7 2460.8 14315.1 14437.1 14507.9 14519.9 14867.3 1986.7 2001.2 2017.1 2022.5 2092.4 65901.5 68888.7 70259.3 71569.3 71950.3 15118.7 15494.6 15567.4 15613.5 15637.8 12467.9 12932.6 12961.5 24786.5 24815.8 7343.5 7457.6 7596.7 7601.2 7630.9 7486.3 7495.4 7497.6 7527.1 7575.4 4359.7 4383.7 4392.9 4406.3 4407.9 1819.1 1849.6 1870.9 1901.1 1918.3 914.1 928.8 939.3 993.5 1011.4 16486.3 16614.6 16825.2 16829.3 17116.1 828.9 886.5 921.2 930.5 1026.2 6075.9 6312.1 6319.2 6398.7 6404.9 418257.0 512605.0 522638.0 529167.0 529729.0 82786.6 83607.0 84043.0 84240.0 84722.0 493.9 494.7 497.2 500.7 501.2 10889.3 10921.3 10981.9 11091.3 11159.9 31904.0 34485.0 34576.7 36323.5 36698.4 40080.8 41972.8 43361.0 43606.3 44234.0 9551.6 9668.6 9906.7 9921.8 9933.5 11422.4 11493.3 14930.4 17820.6 18395.4 13961.7 14073.7 14621.0 15099.1 15255.2 14251.4 14361.1 14536.3 14791.9 14973.9 15130.2 15354.4 15355.5 15672.2 15714.4 9691.1 9825.0 9913.4 9955.4 10045.9 12512.8 14919.5 15162.7 15186.2 15273.5 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#3] mootools.html Cycles:180 Average:4755.33 Median:5904.08 stddev:2369.50 (40.1%) stddev-sans-first:2362.65 17:05:06 INFO - PROCESS | 3479 | Values: 1390.6 1409.0 1522.6 1691.8 1697.2 5729.9 5740.0 6490.5 6612.7 6613.0 6414.3 6437.9 6543.5 6552.1 6564.1 2059.1 2072.9 2088.6 2089.7 2094.9 2069.0 2105.2 2116.9 2120.3 2124.1 2081.6 2095.0 2113.7 2119.7 2126.2 2098.8 2102.4 2104.5 2122.6 2124.7 2049.3 2061.7 2113.2 2115.1 2116.3 6649.2 6670.3 6747.7 6752.4 6753.8 4119.3 4147.7 4149.0 4168.9 4186.0 2774.6 2796.9 2844.5 2858.8 2862.5 920.9 963.6 966.2 986.4 988.2 8831.2 8844.6 8863.1 8870.0 8884.4 3778.2 3826.4 3894.8 3897.9 3901.2 7766.0 7782.2 7797.0 7853.1 7873.8 4196.8 4257.3 4260.3 4268.8 4268.8 3810.1 3860.8 3868.5 3879.0 3881.8 3247.1 3253.2 3288.8 3300.8 3307.4 1000.3 1001.4 1003.9 1007.2 1007.7 1023.4 1077.8 1235.6 1251.9 1281.7 6248.1 6253.8 6300.4 6304.0 6312.8 617.7 637.4 640.8 642.9 776.2 5041.8 5241.5 5251.3 5251.8 5262.8 7904.4 8017.7 8096.2 8151.9 8176.9 8009.7 8065.6 8068.7 8093.7 8108.2 6372.5 6396.4 6433.8 6460.4 6463.5 6054.2 6231.2 6234.8 6235.3 6240.8 7128.8 7130.3 7157.4 7278.4 7342.5 7216.5 7275.0 7287.0 7288.4 7340.8 5758.7 5767.4 5825.3 5827.9 5912.1 6436.5 6441.9 6448.7 6453.9 6481.6 5987.1 6190.0 6203.3 6266.5 6288.5 5929.2 5942.5 6016.0 6044.3 6094.5 6204.3 6205.8 6297.3 6339.0 6366.1 5641.9 5733.3 5752.4 5771.9 5806.4 5597.0 5610.4 5792.2 5879.9 5896.1 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#4] prototype.html Cycles:180 Average:5600.07 Median:6228.66 stddev:1688.65 (27.1%) stddev-sans-first:1646.36 17:05:06 INFO - PROCESS | 3479 | Values: 327.4 327.5 330.8 335.4 337.9 6236.6 6324.1 6330.7 6357.3 6378.0 6134.4 6310.4 6321.4 6333.1 6345.1 4814.3 4830.1 4839.2 4850.6 4852.1 4843.5 4852.5 4857.1 4859.9 4863.7 4701.6 4753.7 4757.4 4759.8 4784.7 4765.5 4773.7 4786.5 4789.5 4789.7 4181.3 4187.2 4194.2 4200.7 4210.7 5962.2 5990.5 5998.0 6020.2 6021.7 5525.6 5633.2 5642.2 5655.2 5664.2 6692.0 6702.0 6718.8 6720.8 6724.8 4677.2 4700.3 4700.8 4702.7 4704.5 6743.1 6938.7 6941.9 6983.2 7032.5 4702.7 4735.3 4737.5 4751.8 4755.8 4764.4 4801.1 4817.0 4823.5 4832.6 5556.6 5570.5 5577.6 5634.7 5653.8 6569.6 6807.2 6828.8 6838.7 6853.6 1706.3 1710.1 1749.1 1749.5 1751.6 1113.0 1133.6 1156.9 1163.7 1174.5 6152.1 6180.8 6186.9 6199.4 6208.5 6718.5 6733.2 6740.0 6752.1 6753.9 6044.5 6187.6 6189.2 6192.5 6220.7 3730.1 3746.9 3747.9 3758.4 3763.2 7108.5 7122.8 7131.3 7143.8 7147.2 6863.2 6976.7 6991.1 6991.2 7006.5 7103.6 7107.3 7128.6 7133.8 7136.1 6806.1 6825.1 6857.9 6858.8 6859.7 6708.5 6796.8 6826.1 6827.5 6904.8 7208.1 7376.5 7381.4 7388.8 7388.9 4675.8 4718.9 4730.4 4737.2 4738.8 6844.9 6973.5 7000.1 7010.1 7053.0 6825.9 6826.5 6831.6 6841.2 6856.3 6809.6 6823.1 6829.5 6830.9 6852.4 6448.7 6495.0 6531.1 6559.7 6581.1 6829.1 6837.7 6846.3 6849.3 6853.3 6636.7 6670.3 6693.0 6702.6 6708.8 17:05:06 INFO - PROCESS | 3479 | 17:05:06 INFO - PROCESS | 3479 | [#5] yui.html Cycles:180 Average:13008.10 Median:49029.00 stddev:15321.45 (31.2%) stddev-sans-first:15336.74 17:05:06 INFO - PROCESS | 3479 | Values: 742.2 801.9 823.7 827.3 828.6 12698.2 12859.7 12882.4 12923.2 12929.4 11827.9 11998.6 11999.8 12035.8 12693.7 795.4 805.0 809.2 809.6 809.8 806.1 806.8 809.8 813.1 815.5 835.4 838.9 839.0 840.1 842.1 825.7 833.6 833.9 834.3 837.5 608.8 610.7 611.1 612.7 613.3 13361.4 13466.8 13540.0 13560.3 13560.9 11699.2 12189.6 12372.5 12533.5 12610.2 10223.7 10423.3 10503.4 10557.2 10698.6 3575.8 3613.6 3633.9 3668.2 3756.1 42275.4 42724.4 42772.8 42816.4 42832.1 9399.3 9812.4 9829.8 9901.3 9998.5 16932.3 16978.0 16980.6 16990.6 17007.0 7157.6 7302.7 7331.5 7430.4 7494.9 4131.6 4222.2 4259.5 4321.7 4338.3 2996.5 3001.6 3011.0 3017.7 3024.7 527.4 549.4 551.5 567.4 567.6 439.5 461.9 476.4 489.4 506.7 7216.2 7224.9 7325.4 7377.6 7385.9 488.5 488.9 516.8 518.2 555.4 3247.4 3264.6 3527.1 3551.6 3593.1 54969.5 55344.4 55422.7 55453.0 58629.7 48028.0 48823.3 49019.0 49039.0 49839.0 45580.5 45730.8 45746.3 46589.3 46840.0 6784.3 6797.9 6895.5 6976.9 6982.6 32694.5 33513.5 34482.0 34761.0 36212.3 41097.6 42378.4 42600.4 43844.3 43934.6 9885.7 9895.3 10050.8 10394.0 10487.8 10692.3 11432.6 11595.1 11832.6 12116.6 8702.3 9223.1 9998.7 10099.0 10530.6 9075.0 9247.2 9428.0 9444.5 9557.1 9841.8 9956.4 9996.8 10020.6 10182.6 8141.5 8254.6 8547.5 8636.4 8645.5 8111.0 8136.4 8162.3 8241.5 8255.1 17:05:06 INFO - PROCESS | 3479 | -------- Summary: end -------- 17:05:06 INFO - PROCESS | 3479 | 17:05:07 INFO - TEST-INFO | 3479: exit 0 17:05:07 INFO - TEST-OK | dromaeo_css | took 1112196ms 17:05:07 INFO - TEST-START | kraken 17:05:07 INFO - operating with platform_type : linux_ 17:05:07 INFO - Initialising browser for kraken test... 17:05:07 INFO - TEST-INFO | started process 3724 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbna57_/profile http://localhost:41718/getInfo.html) 17:05:11 INFO - PROCESS | 3724 | __metrics Screen width/height:1600/1200 17:05:11 INFO - PROCESS | 3724 | colorDepth:24 17:05:11 INFO - PROCESS | 3724 | Browser inner width/height: 1024/697 17:05:11 INFO - PROCESS | 3724 | __metrics 17:05:11 INFO - PROCESS | 3724 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:05:12 INFO - TEST-INFO | 3724: exit 0 17:05:12 INFO - Browser initialized. 17:05:12 INFO - Running cycle 1/1 for kraken test... 17:05:12 INFO - TEST-INFO | started process 3846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbna57_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:24 INFO - PROCESS | 3846 | RSS: Main: 149909504 17:05:24 INFO - PROCESS | 3846 | 17:05:26 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41718/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:27 INFO - PROCESS | 3846 | RSS: Main: 151085056 17:05:27 INFO - PROCESS | 3846 | 17:05:30 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41718/tests/kraken/driver.html?testName=audio-dft) 17:05:30 INFO - PROCESS | 3846 | RSS: Main: 151752704 17:05:30 INFO - PROCESS | 3846 | 17:05:33 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41718/tests/kraken/driver.html?testName=audio-fft) 17:05:34 INFO - PROCESS | 3846 | RSS: Main: 145448960 17:05:34 INFO - PROCESS | 3846 | 17:05:36 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41718/tests/kraken/driver.html?testName=audio-oscillator) 17:05:36 INFO - PROCESS | 3846 | RSS: Main: 146210816 17:05:36 INFO - PROCESS | 3846 | 17:05:38 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41718/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:39 INFO - PROCESS | 3846 | RSS: Main: 146862080 17:05:39 INFO - PROCESS | 3846 | 17:05:42 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41718/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:43 INFO - PROCESS | 3846 | RSS: Main: 146980864 17:05:43 INFO - PROCESS | 3846 | 17:05:46 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41718/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:46 INFO - PROCESS | 3846 | RSS: Main: 148594688 17:05:46 INFO - PROCESS | 3846 | 17:05:49 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41718/tests/kraken/driver.html?testName=json-parse-financial) 17:05:50 INFO - PROCESS | 3846 | RSS: Main: 148574208 17:05:50 INFO - PROCESS | 3846 | 17:05:51 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41718/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:52 INFO - PROCESS | 3846 | RSS: Main: 148189184 17:05:52 INFO - PROCESS | 3846 | 17:05:54 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:54 INFO - PROCESS | 3846 | RSS: Main: 148787200 17:05:54 INFO - PROCESS | 3846 | 17:05:57 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:57 INFO - PROCESS | 3846 | RSS: Main: 149270528 17:05:57 INFO - PROCESS | 3846 | 17:06:00 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:06:00 INFO - PROCESS | 3846 | RSS: Main: 149659648 17:06:00 INFO - PROCESS | 3846 | 17:06:03 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:06:03 INFO - PROCESS | 3846 | RSS: Main: 148398080 17:06:03 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | Cycle 1(1): loaded http://localhost:41718/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41718/tests/kraken/driver.html?testName=ai-astar) 17:06:05 INFO - PROCESS | 3846 | RSS: Main: 148541440 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | __start_tp_report 17:06:05 INFO - PROCESS | 3846 | _x_x_mozilla_page_load 17:06:05 INFO - PROCESS | 3846 | _x_x_mozilla_page_load_details 17:06:05 INFO - PROCESS | 3846 | |i|pagename|runs| 17:06:05 INFO - PROCESS | 3846 | |0;ai-astar;115;106;113;111;110;122;111;111;112;111 17:06:05 INFO - PROCESS | 3846 | |1;audio-beat-detection;147;128;148;170;130;154;159;134;166;128 17:06:05 INFO - PROCESS | 3846 | |2;audio-dft;161;163;163;163;161;161;160;164;170;164 17:06:05 INFO - PROCESS | 3846 | |3;audio-fft;73;84;71;75;72;150;72;73;73;73 17:06:05 INFO - PROCESS | 3846 | |4;audio-oscillator;98;97;142;95;97;96;138;96;98;144 17:06:05 INFO - PROCESS | 3846 | |5;imaging-gaussian-blur;110;110;109;110;112;110;110;109;109;109 17:06:05 INFO - PROCESS | 3846 | |6;imaging-darkroom;147;147;148;148;148;148;148;147;149;148 17:06:05 INFO - PROCESS | 3846 | |7;imaging-desaturate;96;97;96;97;97;97;97;96;97;96 17:06:05 INFO - PROCESS | 3846 | |8;json-parse-financial;60;59;58;59;61;62;59;62;55;57 17:06:05 INFO - PROCESS | 3846 | |9;json-stringify-tinderbox;67;68;67;67;67;67;67;68;67;68 17:06:05 INFO - PROCESS | 3846 | |10;stanford-crypto-aes;94;88;87;87;88;87;87;86;96;88 17:06:05 INFO - PROCESS | 3846 | |11;stanford-crypto-ccm;119;130;125;125;127;131;131;121;120;127 17:06:05 INFO - PROCESS | 3846 | |12;stanford-crypto-pbkdf2;142;151;139;150;153;140;156;154;157;152 17:06:05 INFO - PROCESS | 3846 | |13;stanford-crypto-sha256-iterative;69;68;71;67;69;68;69;68;68;66 17:06:05 INFO - PROCESS | 3846 | __end_tp_report 17:06:05 INFO - PROCESS | 3846 | __start_cc_report 17:06:05 INFO - PROCESS | 3846 | _x_x_mozilla_cycle_collect,733 17:06:05 INFO - PROCESS | 3846 | __end_cc_report 17:06:05 INFO - PROCESS | 3846 | __startTimestamp1451437565858__endTimestamp 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | ------- Summary: start ------- 17:06:05 INFO - PROCESS | 3846 | Number of tests: 14 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#0] ai-astar Cycles:10 Average:112.20 Median:111.50 stddev:4.13 (3.7%) stddev-sans-first:4.26 17:06:05 INFO - PROCESS | 3846 | Values: 115.0 106.0 113.0 111.0 110.0 122.0 111.0 111.0 112.0 111.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:151.00 stddev:15.85 (10.5%) stddev-sans-first:16.81 17:06:05 INFO - PROCESS | 3846 | Values: 147.0 128.0 148.0 170.0 130.0 154.0 159.0 134.0 166.0 128.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.83 (1.7%) stddev-sans-first:2.91 17:06:05 INFO - PROCESS | 3846 | Values: 161.0 163.0 163.0 163.0 161.0 161.0 160.0 164.0 170.0 164.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#3] audio-fft Cycles:10 Average:81.60 Median:73.00 stddev:24.31 (33.3%) stddev-sans-first:25.59 17:06:05 INFO - PROCESS | 3846 | Values: 73.0 84.0 71.0 75.0 72.0 150.0 72.0 73.0 73.0 73.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.50 stddev:21.62 (22.4%) stddev-sans-first:22.48 17:06:05 INFO - PROCESS | 3846 | Values: 98.0 97.0 142.0 95.0 97.0 96.0 138.0 96.0 98.0 144.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:06:05 INFO - PROCESS | 3846 | Values: 110.0 110.0 109.0 110.0 112.0 110.0 110.0 109.0 109.0 109.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 17:06:05 INFO - PROCESS | 3846 | Values: 147.0 147.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 148.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 17:06:05 INFO - PROCESS | 3846 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 97.0 96.0 97.0 96.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.50 stddev:2.20 (3.7%) stddev-sans-first:2.32 17:06:05 INFO - PROCESS | 3846 | Values: 60.0 59.0 58.0 59.0 61.0 62.0 59.0 62.0 55.0 57.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:06:05 INFO - PROCESS | 3846 | Values: 67.0 68.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.00 stddev:3.36 (3.8%) stddev-sans-first:2.99 17:06:05 INFO - PROCESS | 3846 | Values: 94.0 88.0 87.0 87.0 88.0 87.0 87.0 86.0 96.0 88.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:4.45 (3.5%) stddev-sans-first:4.03 17:06:05 INFO - PROCESS | 3846 | Values: 119.0 130.0 125.0 125.0 127.0 131.0 131.0 121.0 120.0 127.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:152.50 stddev:6.64 (4.4%) stddev-sans-first:6.48 17:06:05 INFO - PROCESS | 3846 | Values: 142.0 151.0 139.0 150.0 153.0 140.0 156.0 154.0 157.0 152.0 17:06:05 INFO - PROCESS | 3846 | 17:06:05 INFO - PROCESS | 3846 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.34 (2.0%) stddev-sans-first:1.39 17:06:05 INFO - PROCESS | 3846 | Values: 69.0 68.0 71.0 67.0 69.0 68.0 69.0 68.0 68.0 66.0 17:06:05 INFO - PROCESS | 3846 | -------- Summary: end -------- 17:06:05 INFO - PROCESS | 3846 | 17:06:06 INFO - TEST-INFO | 3846: exit 0 17:06:06 INFO - TEST-OK | kraken | took 59546ms 17:06:06 INFO - TEST-START | v8_7 17:06:06 INFO - operating with platform_type : linux_ 17:06:06 INFO - Initialising browser for v8_7 test... 17:06:06 INFO - TEST-INFO | started process 4133 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMu5YDe/profile http://localhost:41718/getInfo.html) 17:06:11 INFO - PROCESS | 4133 | __metrics Screen width/height:1600/1200 17:06:11 INFO - PROCESS | 4133 | colorDepth:24 17:06:11 INFO - PROCESS | 4133 | Browser inner width/height: 1024/697 17:06:11 INFO - PROCESS | 4133 | __metrics 17:06:11 INFO - PROCESS | 4133 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:06:12 INFO - TEST-INFO | 4133: exit 0 17:06:12 INFO - Browser initialized. 17:06:12 INFO - Running cycle 1/1 for v8_7 test... 17:06:12 INFO - TEST-INFO | started process 4255 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMu5YDe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:23 INFO - PROCESS | 4255 | RSS: Main: 149405696 17:06:23 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | Cycle 1(1): loaded http://localhost:41718/tests/v8_7/run.html (next: http://localhost:41718/tests/v8_7/run.html) 17:06:45 INFO - PROCESS | 4255 | RSS: Main: 146206720 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | __start_tp_report 17:06:45 INFO - PROCESS | 4255 | _x_x_mozilla_page_load 17:06:45 INFO - PROCESS | 4255 | _x_x_mozilla_page_load_details 17:06:45 INFO - PROCESS | 4255 | |i|pagename|runs| 17:06:45 INFO - PROCESS | 4255 | |0;Richards;166.16816218012627 17:06:45 INFO - PROCESS | 4255 | |1;DeltaBlue;191.3143294432753 17:06:45 INFO - PROCESS | 4255 | |2;Encrypt;280.58361391694723 17:06:45 INFO - PROCESS | 4255 | |3;Decrypt;5196.891191709845 17:06:45 INFO - PROCESS | 4255 | |4;RayTrace;1043.8413361169103 17:06:45 INFO - PROCESS | 4255 | |5;Earley;711.2375533428165 17:06:45 INFO - PROCESS | 4255 | |6;Boyer;12280.487804878048 17:06:45 INFO - PROCESS | 4255 | |7;RegExp;25025 17:06:45 INFO - PROCESS | 4255 | |8;Splay;700.3484320557492 17:06:45 INFO - PROCESS | 4255 | |9;NavierStokes;4845.410628019324 17:06:45 INFO - PROCESS | 4255 | __end_tp_report 17:06:45 INFO - PROCESS | 4255 | __startTimestamp1451437605527__endTimestamp 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | ------- Summary: start ------- 17:06:45 INFO - PROCESS | 4255 | Number of tests: 10 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 166.2 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#1] DeltaBlue Cycles:1 Average:191.31 Median:191.31 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 191.3 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 280.6 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 5196.9 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#4] RayTrace Cycles:1 Average:1043.84 Median:1043.84 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 1043.8 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#5] Earley Cycles:1 Average:711.24 Median:711.24 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 711.2 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 12280.5 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 25025.0 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#8] Splay Cycles:1 Average:700.35 Median:700.35 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 700.3 17:06:45 INFO - PROCESS | 4255 | 17:06:45 INFO - PROCESS | 4255 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:06:45 INFO - PROCESS | 4255 | Values: 4845.4 17:06:45 INFO - PROCESS | 4255 | -------- Summary: end -------- 17:06:45 INFO - PROCESS | 4255 | 17:06:46 INFO - TEST-INFO | 4255: exit 0 17:06:46 INFO - TEST-OK | v8_7 | took 39600ms 17:06:46 INFO - SUITE-END | took 1211s 17:06:46 INFO - Completed test suite (00:20:11) 17:06:46 INFO - Working with test: dromaeo_css 17:06:46 INFO - Generating results file: dromaeo_css 17:06:46 INFO - Working with test: kraken 17:06:46 INFO - Generating results file: kraken 17:06:46 INFO - javascript benchmark 17:06:46 INFO - Working with test: v8_7 17:06:46 INFO - Generating results file: v8_7 17:06:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 17:06:46 INFO - process_Request line: dromaeo_css 6781.45 graph.html#tests=[[72,64,43]] 17:06:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:46 INFO - process_Request line: kraken 1526.10 graph.html#tests=[[232,64,43]] 17:06:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:46 INFO - process_Request line: v8_7 21085.45 graph.html#tests=[[230,64,43]] 17:06:46 INFO - RETURN: dromaeo_css: 6781.45 17:06:46 INFO - RETURN: kraken: 1526.10 17:06:46 INFO - RETURN: v8_7: 21085.45 17:06:46 INFO - javascript benchmark 17:06:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3105.829179395133, 3147.449196390631, 3178.221335772736, 3201.7278531324837, 3216.774825762196, 5103.821366252182, 5179.093658609742, 5184.9222261666055, 5186.299849520314, 5268.236105764662, 5140.7172605506685, 5174.0, 5200.765965531551, 5225.451327610594, 5238.26664267002, 4748.358971538842, 4764.0, 4785.258284965836, 4793.18515852306, 4862.17343051682, 4515.345274935133, 4772.761361931907, 4786.994731106472, 4838.322634831126, 4849.660523763338, 4652.604528615072, 4661.300804879262, 4731.148393289223, 4748.121597504472, 4754.144254034272, 4791.616670666338, 4798.5441383068555, 4798.736069516175, 4808.951910480885, 4833.371661683958, 4569.2689169732685, 4738.407699037621, 4757.762111894392, 4776.785044672998, 4817.590504807095, 4932.432770231433, 4962.9007419851405, 4990.326305948687, 5024.824131155428, 5026.396832380138, 5574.303212098488, 5581.190727344512, 5582.720863956786, 5602.551795856321, 5650.74571644277, 5533.916991245134, 5630.746616402272, 5633.239512665778, 5635.492805647511, 5637.3235211774845, 5212.478752124795, 5259.211118332242, 5269.446708095633, 5279.340082489689, 5330.840074797762, 5687.289088863892, 5690.2033715279895, 5691.089425691869, 5702.0591602385975, 5715.085586306171, 5307.787688492494, 5442.455754424605, 5485.945140548623, 5532.972335138298, 5560.972195138998, 5596.944030559643, 5599.776008959596, 5603.411641777555, 5632.324121105494, 5649.180868774005, 5542.473465020817, 5579.637323573955, 5607.579431542651, 5609.859753506195, 5615.354234263112, 5505.394406615269, 5546.473085056913, 5559.082751346064, 5609.607327487119, 5642.125470552071, 4345.608895199447, 4349.369341445473, 4358.21552120615, 4366.868993930188, 4384.0355121873135, 3900.863469778544, 3919.451276821247, 3930.8231129599235, 3961.1285517186175, 4006.4390985262085, 5151.562117220078, 5241.868953276198, 5254.395744489356, 5299.894002119936, 5321.042212401805, 5574.108142697149, 5586.776528938878, 5603.663780173202, 5611.0, 5652.406497317805, 5195.402528709247, 5267.394249661262, 5268.446813084571, 5269.604779641542, 5308.893822123536, 4790.209615413488, 4823.27650852368, 4853.587445067209, 4869.853904382874, 4879.902401951941, 5777.884442311214, 5778.422157784272, 5783.479486846204, 5785.074388097968, 5791.594588378773, 5470.452954704498, 5605.32736071674, 5607.859803504945, 5616.85957851057, 5649.20911072442, 5614.354349249726, 5806.767729290781, 5855.853603659943, 5864.648121112747, 5887.764489420375, 5613.88772224545, 5618.550515958632, 5621.747021383966, 5625.634333768292, 5643.125315576092, 5537.889242215214, 5628.437156284339, 5639.943600563942, 5708.257926469699, 5712.571557133148, 5443.510084092451, 5461.0716178248995, 5473.890522189614, 5475.6440831345835, 5525.475079867406, 5428.4842939920645, 5484.341878974548, 5520.171974203901, 5521.585881059017, 5526.972365138309, 5163.0706472833745, 5256.710880901587, 5336.813211537577, 5356.196570514454, 5380.300560927054, 5535.086710692691, 5571.526420254324, 5576.219329293983, 5583.553315734813, 5591.720413979204, 5365.034293827149, 5365.785368585369, 5369.865753356041, 5376.0591896418755, 5478.835634930959], "unit": "score", "name": "dojo.html", "value": 5167.552028730496}, {"lowerIsBetter": false, "replicates": [505.2673623246294, 567.8586042055467, 573.936866944636, 579.0503574138411, 581.1079992211953, 26145.0, 35066.649333506655, 35563.82218088906, 35656.82171589145, 35690.821545892264, 38484.42273365902, 38889.61110388895, 38943.221135577274, 38982.0, 39012.21975560487, 8390.286825619829, 8522.74431767048, 8540.78648033801, 8555.914440855606, 8565.614547345385, 8245.299149572293, 8351.665933362658, 8374.120717324684, 8380.287675547555, 8420.747377578682, 8371.0, 8434.114417986115, 8446.535440550768, 8457.57712114395, 8485.575721213945, 8057.435979481439, 8190.713325033625, 8191.221833925797, 8196.631151598192, 8235.464694794879, 8228.670853165866, 8305.086440491541, 8369.49783013015, 8371.83256334876, 8533.701320453816, 38305.808470957745, 38843.8057809712, 39047.0, 39259.41110883339, 39309.80345098285, 3107.1765982014786, 3152.7477801775804, 3449.9243088200083, 3478.617352091268, 3791.3613174263014, 28695.713042869513, 28732.281692957633, 28926.0, 29472.115836524725, 29964.101076967727, 3875.2830726315724, 3935.232629637222, 3986.760794352319, 3990.8004599770184, 4016.402373193607, 262857.0, 263914.9999999981, 264770.0, 265010.0, 265508.0, 38899.80550097288, 55198.17202741962, 55396.16905746417, 55481.89036219253, 55570.72214638901, 49493.0, 59694.70152649209, 60205.69897150486, 60919.6954015236, 61006.69496652488, 14795.704085918222, 14917.104973701613, 14993.700125997419, 15027.699446011018, 15072.0, 11377.089832813355, 11413.600523981788, 11433.599824006285, 11557.479913403917, 11568.710782230342, 17929.462116136536, 17975.191116399794, 17996.190171442056, 18021.0, 18735.531611709543, 7329.853402931912, 7563.9621801890635, 7579.962100189464, 7585.62071896403, 7653.540787552764, 992.8858181309242, 1019.0726438940677, 1035.4512108582312, 1081.8214994525972, 1133.9659810205708, 28616.0, 28764.0, 29275.0, 29596.55605165924, 31198.68801312003, 1040.9843852342221, 1049.8477720730452, 1053.873535175784, 1059.2426415113232, 1140.1278022312938, 14219.573412797426, 14235.359408826627, 14243.359048842827, 14440.85559144416, 14532.0, 318749.0, 320741.0, 321967.0, 322437.0, 322544.0, 49519.75240123776, 50029.49970500321, 50085.49914500881, 50097.74951125221, 50174.74912625414, 1331.3942156318851, 1343.621789432718, 1347.730453909222, 1348.0, 1351.4999450203488, 26660.200193994213, 27333.589996150473, 27433.31416714598, 27790.86104569464, 28010.85994570014, 44753.77623111864, 44782.0, 44785.32822007607, 45141.0, 45183.09633807371, 296852.0, 297689.0, 297808.0, 299008.0, 299281.0, 29807.70192298136, 31280.843595781877, 31708.365832683678, 31767.682323176472, 32007.679923201402, 37023.44464832976, 37545.62454375421, 37644.0, 37878.43182352322, 38521.807390963986, 33810.37835351969, 34690.82654586711, 34793.13017174591, 34932.82533587316, 35134.64865351314, 33940.49089263712, 34732.47901281432, 35365.64634353624, 35385.46921796124, 35490.8225458871, 33429.33141337111, 34007.82996085004, 34456.65543344635, 34588.654113459546, 34622.13444663904, 29108.7089129106, 30316.84841575778, 31616.209594760316, 31746.0, 31825.5226171603, 24232.515349692556, 24464.388390290384, 24729.752702472746, 24990.500189995735, 25019.0], "unit": "score", "name": "ext.html", "value": 17885.248149044848}, {"lowerIsBetter": false, "replicates": [349.55082718706467, 352.2532231668862, 355.147645650439, 356.74136251217857, 358.0654491776463, 11441.59954401596, 11916.880831191686, 16228.10745409002, 17368.73946890796, 18839.623207535842, 17354.305827766875, 17524.474265772016, 17614.91192544039, 17917.193726282316, 17936.282548698036, 6010.939890601093, 6153.476954458876, 6206.975848984912, 6209.192804935352, 6209.565330426872, 4902.828401005965, 6125.234345706786, 6202.658853763064, 6205.131281620576, 6215.906761398583, 6177.876442471148, 6193.473554747852, 6201.379862013785, 6204.224471941007, 6223.875522489548, 6083.878322433548, 6167.506599472032, 6197.597156184834, 6209.161763161983, 6218.751249949996, 5968.403159683997, 5968.940310596882, 5985.9401405986255, 5994.8501287467725, 5997.0, 17601.295948162056, 22245.555088898294, 22352.10591576335, 22471.101155953744, 23422.765772342227, 2243.4839986803127, 2297.9540409191723, 2375.121205154087, 2403.6875206223253, 2460.8031357491536, 14315.144156606651, 14437.133771973715, 14507.854921450757, 14519.854801452062, 14867.256637168099, 1986.701994700792, 2001.1595130045416, 2017.0775252010346, 2022.5247066939257, 2092.4350425385214, 65901.52565880712, 68888.65555672189, 70259.29740702579, 71569.28430715678, 71950.28049719488, 15118.697626047637, 15494.612634684223, 15567.377304907677, 15613.453529126426, 15637.765433518507, 12467.87532124667, 12932.612021639367, 12961.481540738454, 24786.5042699145, 24815.751842481706, 7343.48595598303, 7457.627118644046, 7596.696132154762, 7601.163871974079, 7630.8855367169535, 7486.326230639269, 7495.400367970549, 7497.587632680146, 7527.096748390229, 7575.393968482508, 4359.716618419792, 4383.693141480129, 4392.912141757147, 4406.250937340596, 4407.911841763147, 1819.145001849129, 1849.5653521422455, 1870.9251629934922, 1901.1254822781398, 1918.3189967561316, 914.131575003749, 928.7724507495707, 939.3096074385321, 993.5280741647804, 1011.3931641015332, 16486.258118384703, 16614.620227275034, 16825.2428640709, 16829.32682692703, 17116.14419279031, 828.8768718386499, 886.4592598514901, 921.235374639048, 930.4789317981952, 1026.1790567546082, 6075.878482430327, 6312.116303717483, 6319.210098737658, 6398.712057957403, 6404.871902561923, 418257.0, 512605.0, 522638.0, 529167.0, 529729.0, 82786.58606706928, 83607.0, 84042.99999999878, 84240.0, 84722.0, 493.9382577177853, 494.7452062187976, 497.1920628977911, 500.7246014691905, 501.1980830670897, 10889.346639201673, 10921.327894471458, 10981.945090274497, 11091.279066860629, 11159.888401115884, 31904.0, 34485.0, 34576.654233457346, 36323.45514817333, 36698.44952325664, 40080.79959600183, 41972.79013604912, 43361.0, 43606.34590481082, 44234.0, 9551.570179341807, 9668.56491457872, 9906.653267135904, 9921.751956201153, 9933.453660048766, 11422.428878555873, 11493.252938558968, 14930.402783888523, 17820.55448613795, 18395.356162534248, 13961.720765584834, 14073.718525629225, 14621.0496317739, 15099.094054356774, 15255.160966146968, 14251.429942802586, 14361.066530675473, 14536.273186340852, 14791.92604036973, 14973.870028323761, 15130.243487825785, 15354.385824567338, 15355.539333820003, 15672.216389180723, 15714.371425142866, 9691.12779849817, 9824.950875245579, 9913.405195688281, 9955.402675839472, 10045.94517575644, 12512.812307815571, 14919.477818276308, 15162.696746064796, 15186.24068796578, 15273.465428709942], "unit": "score", "name": "jquery.html", "value": 9007.627182996406}, {"lowerIsBetter": false, "replicates": [1390.6384340071581, 1408.957731268062, 1522.566068670429, 1691.8139004709487, 1697.2447260968866, 5729.914051289234, 5740.0, 6490.513211509138, 6612.6693665316725, 6613.0, 6414.326495717953, 6437.903431448532, 6543.47652187825, 6552.148220731298, 6564.081028655992, 2059.0631262775437, 2072.9274475393363, 2088.592724418739, 2089.676100204471, 2094.9057292421803, 2068.9689654655194, 2105.1789801977243, 2116.87298762074, 2120.268507364957, 2124.076026928291, 2081.583683263346, 2095.0467537270583, 2113.682947557871, 2119.745630524339, 2126.2345555599973, 2098.821600163988, 2102.432343267317, 2104.5264815416563, 2122.61792877282, 2124.6600543913055, 2049.28275103714, 2061.7319748432756, 2113.1652997066226, 2115.058798834519, 2116.312198535467, 6649.202095748541, 6670.3329667033395, 6747.730090796412, 6752.426043786284, 6753.797386078426, 4119.258533463975, 4147.709660323779, 4149.024979129902, 4168.895777605584, 4185.97907010466, 2774.597683335925, 2796.874140663675, 2844.502212112872, 2858.814177078483, 2862.4990626640256, 920.8848893888264, 963.6145541783272, 966.1546147121269, 986.3736527305141, 988.2439933450844, 8831.161039701283, 8844.646214151426, 8863.069377715376, 8870.0, 8884.378093533454, 3778.1688028633657, 3826.4260360945523, 3894.7857867817543, 3897.8830635080994, 3901.219756048745, 7765.961170194113, 7782.221777822286, 7796.961015194887, 7853.136155022943, 7873.842523149505, 4196.790160492024, 4257.297545904891, 4260.275753121977, 4268.765217912983, 4268.807903644343, 3810.0855794609092, 3860.8455661773214, 3868.516435445569, 3879.049632839972, 3881.84472621092, 3247.0745837436216, 3253.2192273854102, 3288.753343499199, 3300.818454984999, 3307.4046671598862, 1000.3247807729754, 1001.399160503692, 1003.8996100389902, 1007.2345017786535, 1007.6674697349857, 1023.4268809466722, 1077.849101125843, 1235.6416639174718, 1251.9374031298398, 1281.6795801049739, 6248.094026366151, 6253.812385628438, 6300.3699630037545, 6303.9684801575695, 6312.810615681537, 617.6788070203559, 637.4072112935015, 640.8494003909078, 642.8746394453037, 776.157868712442, 5041.773120209599, 5241.475852414805, 5251.317328747238, 5251.76367063483, 5262.789488420421, 7904.4071694623135, 8017.717165253648, 8096.230858068474, 8151.918480815116, 8176.918230817735, 8009.679612815538, 8065.556394398364, 8068.677252909818, 8093.676252949816, 8108.189181081844, 6372.490200783926, 6396.42432181106, 6433.806985790434, 6460.3862633049785, 6463.450606698483, 6054.243219597551, 6231.189945307081, 6234.812955611339, 6235.282942461675, 6240.781572644935, 7128.786136415916, 7130.251323610946, 7157.355837974607, 7278.381337586365, 7342.5227360221415, 7216.458765592497, 7274.96362518184, 7287.0, 7288.380487658608, 7340.779776606711, 5758.740856661377, 5767.365589785204, 5825.300963884361, 5827.912581311199, 5912.113183022581, 6436.452901503425, 6441.935580644134, 6448.709808058555, 6453.9354606453335, 6481.643509607017, 5987.126179433983, 6190.0405437157315, 6203.286622038523, 6266.467350275278, 6288.465480434214, 5929.169916211647, 5942.494887934574, 6015.969920150371, 6044.33512313654, 6094.451499365078, 6204.255489341308, 6205.844853878509, 6297.338779428277, 6339.049142628643, 6366.140571023038, 5641.887162256814, 5733.254676891977, 5752.424757524382, 5771.884562308646, 5806.361300257053, 5597.0, 5610.410906854721, 5792.247007888947, 5879.911801323069, 5896.056630939029], "unit": "score", "name": "mootools.html", "value": 3943.253515940662}, {"lowerIsBetter": false, "replicates": [327.44498075761595, 327.4940217364172, 330.81639689972064, 335.35109562995603, 337.91889946412863, 6236.625802451845, 6324.114623952644, 6330.683465826707, 6357.300696923335, 6378.0, 6134.417230363119, 6310.368963103688, 6321.367863213688, 6333.050042493628, 6345.143405640237, 4814.253790662436, 4830.082284365977, 4839.153148199069, 4850.636202284834, 4852.053849499349, 4843.515648435164, 4852.49048849871, 4857.149998750222, 4859.854204373874, 4863.659543831933, 4701.576858082772, 4753.714777113367, 4757.3815403997605, 4759.833405830796, 4784.712917224961, 4765.475797662254, 4773.737444440554, 4786.545278198566, 4789.544993225638, 4789.664723469358, 4181.289180839264, 4187.2044311581, 4194.161167766459, 4200.726952748092, 4210.705250632457, 5962.165296858443, 5990.490808281302, 5998.040313549811, 6020.1872747179, 6021.6989150542295, 5525.557955363562, 5633.211350410946, 5642.153676948449, 5655.236543066716, 5664.235328230719, 6691.955160402054, 6702.028205910165, 6718.764843230463, 6720.764773232962, 6724.83187920301, 4677.204875171195, 4700.29495575663, 4700.811967521295, 4702.741349225791, 4704.506026867198, 6743.089682892844, 6938.722451102, 6941.930580694179, 6983.2318444971015, 7032.542884712478, 4702.6708130431225, 4735.337052812609, 4737.502562230985, 4751.83368582098, 4755.785989630475, 4764.404449443819, 4801.063792560487, 4817.0, 4823.493533179036, 4832.589229915497, 5556.611037227436, 5570.526505247019, 5577.553795696334, 5634.661920284796, 5653.830385088454, 6569.638669873203, 6807.21717002551, 6828.829279268058, 6838.658067096625, 6853.554518956252, 1706.2663054886518, 1710.0765586583107, 1749.0817320906372, 1749.5101371615967, 1751.6496700659918, 1113.0372228022864, 1133.5635780224673, 1156.8900954409319, 1163.6858048326903, 1174.4714878304796, 6152.107944348134, 6180.845478863064, 6186.938130618726, 6199.411055949678, 6208.534359923024, 6718.529702920847, 6733.225679046875, 6740.0, 6752.08846805675, 6753.932460675429, 6044.455998960115, 6187.566870319034, 6189.226346706661, 6192.535559832941, 6220.688965551704, 3730.123420996064, 3746.9437958430644, 3747.8500859965843, 3758.379867321861, 3763.247350529905, 7108.5024048317155, 7122.786316410516, 7131.286871312827, 7143.821404464826, 7147.178074521393, 6863.210730765926, 6976.651167441608, 6991.091158149408, 6991.19601245853, 7006.509544331848, 7103.644817759091, 7107.253738357502, 7128.6435678215885, 7133.785986420416, 7136.143662760398, 6806.081179040766, 6825.146856642919, 6857.931420685729, 6858.828529286808, 6859.691313890987, 6708.496862735412, 6796.830079248059, 6826.112605361272, 6827.453803695593, 6904.827379315558, 7208.06295181623, 7376.520526165782, 7381.446391520765, 7388.815279618053, 7388.889166662397, 4675.76621168947, 4718.929216061831, 4730.385049943486, 4737.194676905004, 4738.810447582196, 6844.8973265402055, 6973.546719463218, 7000.124984376953, 7010.088688470466, 7053.0478385419365, 6825.89761153593, 6826.453883689393, 6831.555948863308, 6841.21326047491, 6856.314368563104, 6809.557378770364, 6823.112995310578, 6829.453643708392, 6830.93169068303, 6852.417544508772, 6448.742050317935, 6495.025746138117, 6531.085648009377, 6559.672016399257, 6581.111549940697, 6829.146356705412, 6837.726490940307, 6846.315368463114, 6849.31506849331, 6853.348931851466, 6636.734530618721, 6670.332966703291, 6692.966535167293, 6702.597844129368, 6708.798736037927], "unit": "score", "name": "prototype.html", "value": 5045.171334102431}, {"lowerIsBetter": false, "replicates": [742.2317900972492, 801.8997625296835, 823.7117009046831, 827.3381294964029, 828.6229765456718, 12698.238105713652, 12859.742805143891, 12882.4202910869, 12923.224606523616, 12929.418176182082, 11827.881721182786, 11998.580049698263, 11999.760004799899, 12035.75928481432, 12693.705567537338, 795.3835777272617, 805.0379796143611, 809.2393150438598, 809.6235250608465, 809.7894547417654, 806.1092492795465, 806.7660378490231, 809.76112046946, 813.1055838577547, 815.4699445360504, 835.4319063037133, 838.932885369172, 838.9538575378351, 840.0549381945311, 842.0737189092011, 825.7357645553425, 833.6498670558381, 833.8749187621845, 834.3492076180589, 837.4975014990987, 608.7625825927892, 610.6885488400903, 611.0711718188373, 612.7150874843219, 613.2702084519408, 13361.398737056856, 13466.797998030037, 13540.0, 13560.254186019765, 13560.864391356157, 11699.23954942926, 12189.634310970685, 12372.505099795997, 12533.498660053587, 12610.243385396814, 10223.744406389826, 10423.270371074028, 10503.369797812156, 10557.208209384251, 10698.625548105856, 3575.8212089395424, 3613.602503724588, 3633.909152271188, 3668.211334563055, 3756.098536351283, 42275.36586951198, 42724.359134613005, 42772.78613606943, 42816.357754633704, 42832.143357132685, 9399.342046056847, 9812.411255324703, 9829.80340393188, 9901.306908516335, 9998.500074996222, 16932.32270709158, 16978.0, 16980.575485612957, 16990.57523561921, 17007.0, 7157.57054576727, 7302.6713797878165, 7331.450141239428, 7430.405567554582, 7494.887576686354, 4131.607497287753, 4222.218889505451, 4259.488861336659, 4321.65426765858, 4338.349247612883, 2996.535536991726, 3001.6097907271915, 3011.036468330113, 3017.6982301770086, 3024.6672865984724, 527.4251066337711, 549.3572520151353, 551.4760977071718, 567.4042255631571, 567.5544697412594, 439.45068664169787, 461.9491855895849, 476.3807050833902, 489.43714728062304, 506.6959824105581, 7216.242294559101, 7224.855502889913, 7325.377342925804, 7377.6311184440565, 7385.852282954311, 488.4870885570137, 488.9168841296988, 516.8242797448886, 518.2304278146948, 555.4140381897057, 3247.399231142246, 3264.5756051713124, 3527.1182204448887, 3551.5560554930635, 3593.1196856770257, 54969.45030549723, 55344.446555534734, 55422.72288638531, 55453.0, 58629.70685146547, 48028.0, 48823.26765098526, 49019.0, 49039.0, 49839.0, 45580.54419455763, 45730.77134614372, 45746.31380529295, 46589.30116048194, 46840.0, 6784.321567843176, 6797.898031529432, 6895.5173137879865, 6976.860462790817, 6982.581045137308, 32694.509582355808, 33513.49729754104, 34482.0, 34761.0, 36212.27575448529, 41097.58902411057, 42378.36432453454, 42600.360994585724, 43844.34233486436, 43934.56065439305, 9885.703428897144, 9895.25785566071, 10050.798984020132, 10394.0, 10487.790244195226, 10692.251542391958, 11432.599859004895, 11595.072394208612, 11832.645020649394, 12116.636500904988, 8702.303815694855, 9223.123803238681, 9998.700038998843, 10099.0, 10530.57877684884, 9075.0, 9247.213986811197, 9428.0, 9444.48055356962, 9557.092076252746, 9841.753956151153, 9956.352837065568, 9996.800063998533, 10020.64927727526, 10182.643607473703, 8141.51150930946, 8254.628541715518, 8547.487150770974, 8636.352273579381, 8645.524496152771, 8111.0, 8136.389770767098, 8162.306203972729, 8241.50550966944, 8255.133211012757], "unit": "score", "name": "yui.html", "value": 5871.80244059676}], "name": "dromaeo_css", "value": 6781.448330038049}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 113.0, 111.0, 110.0, 122.0, 111.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.2}, {"lowerIsBetter": true, "replicates": [147.0, 128.0, 148.0, 170.0, 130.0, 154.0, 159.0, 134.0, 166.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 163.0, 161.0, 161.0, 160.0, 164.0, 170.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.0}, {"lowerIsBetter": true, "replicates": [73.0, 84.0, 71.0, 75.0, 72.0, 150.0, 72.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 142.0, 95.0, 97.0, 96.0, 138.0, 96.0, 98.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 112.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 58.0, 59.0, 61.0, 62.0, 59.0, 62.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [94.0, 88.0, 87.0, 87.0, 88.0, 87.0, 87.0, 86.0, 96.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.8}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 125.0, 125.0, 127.0, 131.0, 131.0, 121.0, 120.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [142.0, 151.0, 139.0, 150.0, 153.0, 140.0, 156.0, 154.0, 157.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 71.0, 67.0, 69.0, 68.0, 69.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1526.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [191.3143294432753], "unit": "score", "name": "DeltaBlue", "value": 345.5987859999999}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1043.8413361169103], "unit": "score", "name": "RayTrace", "value": 708.909462}, {"lowerIsBetter": false, "replicates": [711.2375533428165], "unit": "score", "name": "Earley", "value": 937.0469780000002}, {"lowerIsBetter": false, "replicates": [12280.487804878048], "unit": "score", "name": "Boyer", "value": 54.27007547169812}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [700.3484320557492], "unit": "score", "name": "Splay", "value": 116.35779601990052}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21085.445918510755}]} 17:06:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21085.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6781.45"}}} 17:06:46 INFO - Return code: 0 17:06:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:06:46 INFO - # TBPL SUCCESS # 17:06:46 INFO - Running post-action listener: _resource_record_post_action 17:06:46 INFO - Running post-run listener: _resource_record_post_run 17:06:47 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 10551296; Write bytes: 456085504; Read time: 3484; Write time: 441860 17:06:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15294464; Read time: 0; Write time: 3024 17:06:47 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 8785920; Write bytes: 374771712; Read time: 3164; Write time: 365820 17:06:47 INFO - Running post-run listener: _upload_blobber_files 17:06:47 INFO - Blob upload gear active. 17:06:47 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:06:47 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 17:06:47 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'] 17:06:47 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 17:06:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:49 INFO - (blobuploader) - INFO - Done attempting. 17:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:50 INFO - (blobuploader) - INFO - Done attempting. 17:06:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:50 INFO - Return code: 0 17:06:50 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:06:50 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4400bf3b945f2117b25dbea6d824b47c7b76315243df07fb047340fa321cd65d8e07e7058a21171fe99d20b03c115f3c5a00c83373b505712f3df6043a6ab0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2695e7204dc661b7d6a6a1863cf8351d511b0fe03e975a20e6e6fe06833b4fa6f03161f24a420c30b26e24c0b8c94541b4f5745b2546101e65d99aa37beca73a"} 17:06:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:06:50 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:06:50 INFO - Contents: 17:06:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4400bf3b945f2117b25dbea6d824b47c7b76315243df07fb047340fa321cd65d8e07e7058a21171fe99d20b03c115f3c5a00c83373b505712f3df6043a6ab0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2695e7204dc661b7d6a6a1863cf8351d511b0fe03e975a20e6e6fe06833b4fa6f03161f24a420c30b26e24c0b8c94541b4f5745b2546101e65d99aa37beca73a"} 17:06:50 INFO - Copying logs to upload dir... 17:06:50 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.315056 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-29 17:06:50.267264) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 17:06:50.270658) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 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/c4400bf3b945f2117b25dbea6d824b47c7b76315243df07fb047340fa321cd65d8e07e7058a21171fe99d20b03c115f3c5a00c83373b505712f3df6043a6ab0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2695e7204dc661b7d6a6a1863cf8351d511b0fe03e975a20e6e6fe06833b4fa6f03161f24a420c30b26e24c0b8c94541b4f5745b2546101e65d99aa37beca73a"} build_url:https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/1GWD3FcOQ9iS5GHMs5XAaw/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/c4400bf3b945f2117b25dbea6d824b47c7b76315243df07fb047340fa321cd65d8e07e7058a21171fe99d20b03c115f3c5a00c83373b505712f3df6043a6ab0a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2695e7204dc661b7d6a6a1863cf8351d511b0fe03e975a20e6e6fe06833b4fa6f03161f24a420c30b26e24c0b8c94541b4f5745b2546101e65d99aa37beca73a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-29 17:06:50.296524) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 17:06:50.296890) ========= 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=447a3abc0420b6a47dd38cba000001bf-1451433738.436162-1819712402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-29 17:06:50.381326) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 17:06:50.381691) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-29 17:06:50.382056) ========= ========= Total master_lag: 0.28 =========