builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1450940124.9 results: success (0) buildid: 20151223203216 builduid: d69b72e8d60048309518c154e2962972 revision: c3c230a896320099bc14a1ef4b78e41ecc657b1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.895446) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.896147) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.896471) ========= 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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.932157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.932462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.966097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:24.966378) ========= 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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004612 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.030416) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.030709) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.031130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.031447) ========= 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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-23 22:55: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% 61.0M=0s 2015-12-23 22:55:25 (61.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165345 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.215229) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.215591) ========= 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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.267368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:25.267761) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3c230a896320099bc14a1ef4b78e41ecc657b1f --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 c3c230a896320099bc14a1ef4b78e41ecc657b1f --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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-23 22:55:25,598 truncating revision to first 12 chars 2015-12-23 22:55:25,598 Setting DEBUG logging. 2015-12-23 22:55:25,598 attempt 1/10 2015-12-23 22:55:25,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3c230a89632?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-23 22:55:26,219 unpacking tar archive at: fx-team-c3c230a89632/testing/mozharness/ program finished with exit code 0 elapsedTime=0.905207 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:26.186490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:26.186842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:26.196303) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:26.196649) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-23 22:55:26.197138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-23 22:55:26.197499) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:55:26 INFO - MultiFileLogger online at 20151223 22:55:26 in /builds/slave/test-pgo 22:55:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:55:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:55:26 INFO - {'append_to_log': False, 22:55:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:55:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:55:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:55:26 INFO - 'branch': 'Fx-Team', 22:55:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:55:26 INFO - 'config_files': ('talos/linux_config.py',), 22:55:26 INFO - 'default_actions': ('clobber', 22:55:26 INFO - 'read-buildbot-config', 22:55:26 INFO - 'download-and-extract', 22:55:26 INFO - 'populate-webroot', 22:55:26 INFO - 'create-virtualenv', 22:55:26 INFO - 'install', 22:55:26 INFO - 'run-tests'), 22:55:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:55:26 INFO - 'download_minidump_stackwalk': True, 22:55:26 INFO - 'download_symbols': 'ondemand', 22:55:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:55:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:55:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:55:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:55:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:55:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:55:26 INFO - 'installer_path': 'installer.exe', 22:55:26 INFO - 'log_level': 'info', 22:55:26 INFO - 'log_name': 'talos', 22:55:26 INFO - 'log_to_console': True, 22:55:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:55:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:55:26 INFO - 'opt_config_files': (), 22:55:26 INFO - 'pip_index': False, 22:55:26 INFO - 'sps_profile': False, 22:55:26 INFO - 'sps_profile_interval': 0, 22:55:26 INFO - 'suite': 'dromaeojs-e10s', 22:55:26 INFO - 'system_bits': '64', 22:55:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:55:26 INFO - 'title': 'talos-linux64-ix-027', 22:55:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:55:26 INFO - 'use_talos_json': True, 22:55:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:55:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:55:26 INFO - 'work_dir': 'build'} 22:55:26 INFO - ##### 22:55:26 INFO - ##### Running clobber step. 22:55:26 INFO - ##### 22:55:26 INFO - Running pre-action listener: _resource_record_pre_action 22:55:26 INFO - Running main action method: clobber 22:55:26 INFO - rmtree: /builds/slave/test-pgo/build 22:55:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:55:27 INFO - Running post-action listener: _resource_record_post_action 22:55:27 INFO - ##### 22:55:27 INFO - ##### Running read-buildbot-config step. 22:55:27 INFO - ##### 22:55:27 INFO - Running pre-action listener: _resource_record_pre_action 22:55:27 INFO - Running main action method: read_buildbot_config 22:55:27 INFO - Using buildbot properties: 22:55:27 INFO - { 22:55:27 INFO - "project": "", 22:55:27 INFO - "product": "firefox", 22:55:27 INFO - "script_repo_revision": "production", 22:55:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:55:27 INFO - "repository": "", 22:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:55:27 INFO - "buildid": "20151223203216", 22:55:27 INFO - "pgo_build": "True", 22:55:27 INFO - "basedir": "/builds/slave/test-pgo", 22:55:27 INFO - "buildnumber": 406, 22:55:27 INFO - "slavename": "talos-linux64-ix-027", 22:55:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:55:27 INFO - "platform": "ubuntu64_hw", 22:55:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:55:27 INFO - "branch": "fx-team", 22:55:27 INFO - "repo_path": "integration/fx-team", 22:55:27 INFO - "revision": "c3c230a896320099bc14a1ef4b78e41ecc657b1f", 22:55:27 INFO - "stage_platform": "linux64-pgo", 22:55:27 INFO - "builduid": "d69b72e8d60048309518c154e2962972", 22:55:27 INFO - "slavebuilddir": "test" 22:55:27 INFO - } 22:55:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:55:27 INFO - Running post-action listener: _resource_record_post_action 22:55:27 INFO - ##### 22:55:27 INFO - ##### Running download-and-extract step. 22:55:27 INFO - ##### 22:55:27 INFO - Running pre-action listener: _resource_record_pre_action 22:55:27 INFO - Running main action method: download_and_extract 22:55:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:55: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')]} 22:55:27 INFO - https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/test_packages.json 22:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/test_packages.json 22:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:55:27 INFO - Downloaded 1302 bytes. 22:55:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:55:27 INFO - Using the following test package requirements: 22:55:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:55:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:55:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'jsshell-linux-x86_64.zip'], 22:55:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:55:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:55:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:55:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:55:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:55:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:55:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:55:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:55: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')]} 22:55:27 INFO - https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:28 INFO - Downloaded 23182541 bytes. 22:55:28 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 22:55:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:28 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 22:55:30 INFO - Return code: 0 22:55:30 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 22:55:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:30 INFO - https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:34 INFO - Downloaded 23182541 bytes. 22:55:34 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 22:55:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:55:34 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 22:55:35 INFO - Return code: 0 22:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:35 INFO - https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:36 INFO - Downloaded 11132277 bytes. 22:55:36 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 22:55:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:55:36 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 22:55:36 INFO - Return code: 0 22:55:36 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')]} 22:55:36 INFO - https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlB3di1GSRKOWyBV1S4XJw/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 22:55:40 INFO - Downloaded 54843360 bytes. 22:55:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:55:40 INFO - mkdir: /builds/slave/test-pgo/properties 22:55:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:55:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:55:40 INFO - Contents: 22:55:40 INFO - build_url:https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:55:40 INFO - Running post-action listener: _resource_record_post_action 22:55:40 INFO - Running post-action listener: set_extra_try_arguments 22:55:40 INFO - ##### 22:55:40 INFO - ##### Running populate-webroot step. 22:55:40 INFO - ##### 22:55:40 INFO - Running pre-action listener: _resource_record_pre_action 22:55:40 INFO - Running main action method: populate_webroot 22:55:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:55:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:55:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:55:40 INFO - '--tppagecycles', 22:55:40 INFO - '7'], 22:55:40 INFO - 'tests': ['tsvgm']}}, 22:55:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:55:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:55:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:55:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:55:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:55:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'tests': ['damp', 'tps']}, 22:55:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['damp', 'tps']}, 22:55:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:55:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:55:40 INFO - 'other': {'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'other_l64': {'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'other_nol64': {'tests': ['a11yr', 22:55:40 INFO - 'ts_paint', 22:55:40 INFO - 'tpaint', 22:55:40 INFO - 'sessionrestore', 22:55:40 INFO - 'sessionrestore_no_auto_restore']}, 22:55:40 INFO - 'svgr': {'tests': ['tsvgx', 22:55:40 INFO - 'tsvgr_opacity', 22:55:40 INFO - 'tart', 22:55:40 INFO - 'tscrollx', 22:55:40 INFO - 'cart']}, 22:55:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['tsvgx', 22:55:40 INFO - 'tsvgr_opacity', 22:55:40 INFO - 'tart', 22:55:40 INFO - 'tscrollx', 22:55:40 INFO - 'cart']}, 22:55:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'tests': ['tp5o']}, 22:55:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'talos_options': ['--e10s'], 22:55:40 INFO - 'tests': ['tp5o']}, 22:55:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'talos_options': ['--xperf_path', 22:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:40 INFO - 'tests': ['tp5n']}, 22:55:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:55:40 INFO - 'talos_options': ['--e10s', 22:55:40 INFO - '--xperf_path', 22:55:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:55:40 INFO - 'tests': ['tp5n']}}, 22:55:40 INFO - 'talos.zip': {'path': '', 22:55:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:55:40 INFO - Running post-action listener: _resource_record_post_action 22:55:40 INFO - ##### 22:55:40 INFO - ##### Running create-virtualenv step. 22:55:40 INFO - ##### 22:55:40 INFO - Running pre-action listener: _resource_record_pre_action 22:55:40 INFO - Running main action method: create_virtualenv 22:55:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:55:40 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 22:55:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:55:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:55:40 INFO - Using real prefix '/usr' 22:55:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:55:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:55:43 INFO - Installing pip.................done. 22:55:43 INFO - Return code: 0 22:55:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:55: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')]} 22:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:43 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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:43 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 22:55:43 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 22:55:43 INFO - Using env: {'DISPLAY': ':0', 22:55:43 INFO - 'HOME': '/home/cltbld', 22:55:43 INFO - 'LANG': 'en_US.UTF-8', 22:55:43 INFO - 'LANGUAGE': 'en_US:en', 22:55:43 INFO - 'LOGNAME': 'cltbld', 22:55:43 INFO - 'MAIL': '/var/mail/cltbld', 22:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:43 INFO - 'MOZ_NO_REMOTE': '1', 22:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:43 INFO - 'NO_EM_RESTART': '1', 22:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:43 INFO - 'SHELL': '/bin/bash', 22:55:43 INFO - 'SHLVL': '1', 22:55:43 INFO - 'TERM': 'linux', 22:55:43 INFO - 'TMOUT': '86400', 22:55:43 INFO - 'USER': 'cltbld', 22:55:43 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:43 INFO - '_': '/tools/buildbot/bin/python'} 22:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:43 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 22:55:43 INFO - Cleaning up... 22:55:43 INFO - Return code: 0 22:55:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:55: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')]} 22:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:43 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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:43 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 22:55:43 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 22:55:43 INFO - Using env: {'DISPLAY': ':0', 22:55:43 INFO - 'HOME': '/home/cltbld', 22:55:43 INFO - 'LANG': 'en_US.UTF-8', 22:55:43 INFO - 'LANGUAGE': 'en_US:en', 22:55:43 INFO - 'LOGNAME': 'cltbld', 22:55:43 INFO - 'MAIL': '/var/mail/cltbld', 22:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:43 INFO - 'MOZ_NO_REMOTE': '1', 22:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:43 INFO - 'NO_EM_RESTART': '1', 22:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:43 INFO - 'SHELL': '/bin/bash', 22:55:43 INFO - 'SHLVL': '1', 22:55:43 INFO - 'TERM': 'linux', 22:55:43 INFO - 'TMOUT': '86400', 22:55:43 INFO - 'USER': 'cltbld', 22:55:43 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:43 INFO - '_': '/tools/buildbot/bin/python'} 22:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:43 INFO - Downloading/unpacking psutil>=0.7.1 22:55:43 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 22:55:43 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 22:55:43 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 22:55:43 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 22:55:43 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 22:55:43 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 22:55:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:55:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:55:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:45 INFO - Installing collected packages: psutil 22:55:45 INFO - Running setup.py install for psutil 22:55:45 INFO - building 'psutil._psutil_linux' extension 22:55:45 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 22:55:45 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 22:55:45 INFO - building 'psutil._psutil_posix' extension 22:55:45 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 22:55:45 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 22:55:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:45 INFO - Successfully installed psutil 22:55:45 INFO - Cleaning up... 22:55:45 INFO - Return code: 0 22:55:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:55:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:55:45 INFO - Using env: {'DISPLAY': ':0', 22:55:45 INFO - 'HOME': '/home/cltbld', 22:55:45 INFO - 'LANG': 'en_US.UTF-8', 22:55:45 INFO - 'LANGUAGE': 'en_US:en', 22:55:45 INFO - 'LOGNAME': 'cltbld', 22:55:45 INFO - 'MAIL': '/var/mail/cltbld', 22:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:45 INFO - 'MOZ_NO_REMOTE': '1', 22:55:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:45 INFO - 'NO_EM_RESTART': '1', 22:55:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:45 INFO - 'SHELL': '/bin/bash', 22:55:45 INFO - 'SHLVL': '1', 22:55:45 INFO - 'TERM': 'linux', 22:55:45 INFO - 'TMOUT': '86400', 22:55:45 INFO - 'USER': 'cltbld', 22:55:45 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:45 INFO - '_': '/tools/buildbot/bin/python'} 22:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:46 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 22:55:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:55:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:55:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:55:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:55:47 INFO - Installing collected packages: mozsystemmonitor 22:55:47 INFO - Running setup.py install for mozsystemmonitor 22:55:47 INFO - Successfully installed mozsystemmonitor 22:55:47 INFO - Cleaning up... 22:55:48 INFO - Return code: 0 22:55:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:55: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')]} 22:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55: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')]} 22:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:55:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:55:48 INFO - Using env: {'DISPLAY': ':0', 22:55:48 INFO - 'HOME': '/home/cltbld', 22:55:48 INFO - 'LANG': 'en_US.UTF-8', 22:55:48 INFO - 'LANGUAGE': 'en_US:en', 22:55:48 INFO - 'LOGNAME': 'cltbld', 22:55:48 INFO - 'MAIL': '/var/mail/cltbld', 22:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:48 INFO - 'MOZ_NO_REMOTE': '1', 22:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:48 INFO - 'NO_EM_RESTART': '1', 22:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:48 INFO - 'SHELL': '/bin/bash', 22:55:48 INFO - 'SHLVL': '1', 22:55:48 INFO - 'TERM': 'linux', 22:55:48 INFO - 'TMOUT': '86400', 22:55:48 INFO - 'USER': 'cltbld', 22:55:48 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:48 INFO - '_': '/tools/buildbot/bin/python'} 22:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:49 INFO - Downloading blobuploader-1.2.4.tar.gz 22:55:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:55:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:55:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:55:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:55:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:50 INFO - Downloading docopt-0.6.1.tar.gz 22:55:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:55:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:55:50 INFO - Installing collected packages: blobuploader, requests, docopt 22:55:50 INFO - Running setup.py install for blobuploader 22:55:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:55:50 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:55:50 INFO - Running setup.py install for requests 22:55:51 INFO - Running setup.py install for docopt 22:55:51 INFO - Successfully installed blobuploader requests docopt 22:55:51 INFO - Cleaning up... 22:55:51 INFO - Return code: 0 22:55:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:51 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')]} 22:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:51 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')]} 22:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:51 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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:51 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 22:55:51 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 22:55:51 INFO - Using env: {'DISPLAY': ':0', 22:55:51 INFO - 'HOME': '/home/cltbld', 22:55:51 INFO - 'LANG': 'en_US.UTF-8', 22:55:51 INFO - 'LANGUAGE': 'en_US:en', 22:55:51 INFO - 'LOGNAME': 'cltbld', 22:55:51 INFO - 'MAIL': '/var/mail/cltbld', 22:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:51 INFO - 'MOZ_NO_REMOTE': '1', 22:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:51 INFO - 'NO_EM_RESTART': '1', 22:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:51 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:51 INFO - 'SHELL': '/bin/bash', 22:55:51 INFO - 'SHLVL': '1', 22:55:51 INFO - 'TERM': 'linux', 22:55:51 INFO - 'TMOUT': '86400', 22:55:51 INFO - 'USER': 'cltbld', 22:55:51 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:51 INFO - '_': '/tools/buildbot/bin/python'} 22:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:51 INFO - Running setup.py (path:/tmp/pip-I0TdNh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:51 INFO - Running setup.py (path:/tmp/pip-KSgHvh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:51 INFO - Running setup.py (path:/tmp/pip-2eRUSy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:51 INFO - Running setup.py (path:/tmp/pip-ykVTzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:51 INFO - Running setup.py (path:/tmp/pip-Pyxb2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:51 INFO - Running setup.py (path:/tmp/pip-nkS9Rq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:52 INFO - Running setup.py (path:/tmp/pip-eFxsJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:52 INFO - Running setup.py (path:/tmp/pip-E9QaYj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:52 INFO - Running setup.py (path:/tmp/pip-FDeUhI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:52 INFO - Running setup.py (path:/tmp/pip-KW9dyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:52 INFO - Running setup.py (path:/tmp/pip-Ss8Ugz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:52 INFO - Running setup.py (path:/tmp/pip-kA9_C7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:52 INFO - Running setup.py (path:/tmp/pip-Q5oT8w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:52 INFO - Running setup.py (path:/tmp/pip-24Keng-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:52 INFO - Running setup.py (path:/tmp/pip-oe3f0Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:52 INFO - Running setup.py (path:/tmp/pip-BYSVdK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:52 INFO - Running setup.py (path:/tmp/pip-_kc1D0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:55:52 INFO - Running setup.py install for manifestparser 22:55:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:55:52 INFO - Running setup.py install for mozcrash 22:55:53 INFO - Running setup.py install for mozdebug 22:55:53 INFO - Running setup.py install for mozdevice 22:55:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for mozfile 22:55:53 INFO - Running setup.py install for mozhttpd 22:55:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for mozinfo 22:55:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for mozInstall 22:55:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for mozleak 22:55:53 INFO - Running setup.py install for mozlog 22:55:53 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for moznetwork 22:55:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:55:53 INFO - Running setup.py install for mozprocess 22:55:54 INFO - Running setup.py install for mozprofile 22:55:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:55:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:55:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:55:54 INFO - Running setup.py install for mozrunner 22:55:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:55:54 INFO - Running setup.py install for mozscreenshot 22:55:54 INFO - Running setup.py install for moztest 22:55:54 INFO - Running setup.py install for mozversion 22:55:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:55:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:55:54 INFO - Cleaning up... 22:55:54 INFO - Return code: 0 22:55:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:54 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')]} 22:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:54 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')]} 22:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:54 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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:54 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 22:55:54 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 22:55:54 INFO - Using env: {'DISPLAY': ':0', 22:55:54 INFO - 'HOME': '/home/cltbld', 22:55:54 INFO - 'LANG': 'en_US.UTF-8', 22:55:54 INFO - 'LANGUAGE': 'en_US:en', 22:55:54 INFO - 'LOGNAME': 'cltbld', 22:55:54 INFO - 'MAIL': '/var/mail/cltbld', 22:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:54 INFO - 'MOZ_NO_REMOTE': '1', 22:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:54 INFO - 'NO_EM_RESTART': '1', 22:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:54 INFO - 'SHELL': '/bin/bash', 22:55:54 INFO - 'SHLVL': '1', 22:55:54 INFO - 'TERM': 'linux', 22:55:54 INFO - 'TMOUT': '86400', 22:55:54 INFO - 'USER': 'cltbld', 22:55:54 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:54 INFO - '_': '/tools/buildbot/bin/python'} 22:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:54 INFO - Running setup.py (path:/tmp/pip-e3dIGH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:55:54 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)) 22:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:54 INFO - Running setup.py (path:/tmp/pip-2pBGYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:55 INFO - Running setup.py (path:/tmp/pip-didQay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:55 INFO - Running setup.py (path:/tmp/pip-5JRo4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:55 INFO - Running setup.py (path:/tmp/pip-kVyr79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:55 INFO - Running setup.py (path:/tmp/pip-mdRHIc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:55 INFO - Running setup.py (path:/tmp/pip-XQDY9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:55 INFO - Running setup.py (path:/tmp/pip-q_LyUW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:55 INFO - Running setup.py (path:/tmp/pip-8viqcw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:55 INFO - Running setup.py (path:/tmp/pip-dGnUXs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:55 INFO - Running setup.py (path:/tmp/pip-S3mHEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:55 INFO - Running setup.py (path:/tmp/pip-4VoMvA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:55 INFO - Running setup.py (path:/tmp/pip-YqG5RN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:55 INFO - Running setup.py (path:/tmp/pip-1DgZbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:55 INFO - Running setup.py (path:/tmp/pip-C0FSWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:55:55 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)) 22:55:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:55 INFO - Running setup.py (path:/tmp/pip-ErFMbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:55:56 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)) 22:55:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:56 INFO - Running setup.py (path:/tmp/pip-iA1zzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:55:56 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)) 22:55:56 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)) 22:55:56 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)) 22:55:56 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)) 22:55:56 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)) 22:55:56 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)) 22:55:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:55:56 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 22:55:56 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 22:55:56 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 22:55:56 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 22:55:56 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 22:55:56 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 22:55:57 INFO - Downloading blessings-1.5.1.tar.gz 22:55:57 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 22:55:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:55:57 INFO - Installing collected packages: blessings 22:55:57 INFO - Running setup.py install for blessings 22:55:57 INFO - Successfully installed blessings 22:55:57 INFO - Cleaning up... 22:55:58 INFO - Return code: 0 22:55:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:55:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:55:58 INFO - Reading from file tmpfile_stdout 22:55:58 INFO - Current package versions: 22:55:58 INFO - argparse == 1.2.1 22:55:58 INFO - blessings == 1.5.1 22:55:58 INFO - blobuploader == 1.2.4 22:55:58 INFO - docopt == 0.6.1 22:55:58 INFO - manifestparser == 1.1 22:55:58 INFO - mozInstall == 1.12 22:55:58 INFO - mozcrash == 0.16 22:55:58 INFO - mozdebug == 0.1 22:55:58 INFO - mozdevice == 0.47 22:55:58 INFO - mozfile == 1.2 22:55:58 INFO - mozhttpd == 0.7 22:55:58 INFO - mozinfo == 0.9 22:55:58 INFO - mozleak == 0.1 22:55:58 INFO - mozlog == 3.1 22:55:58 INFO - moznetwork == 0.27 22:55:58 INFO - mozprocess == 0.22 22:55:58 INFO - mozprofile == 0.28 22:55:58 INFO - mozrunner == 6.11 22:55:58 INFO - mozscreenshot == 0.1 22:55:58 INFO - mozsystemmonitor == 0.0 22:55:58 INFO - moztest == 0.7 22:55:58 INFO - mozversion == 1.4 22:55:58 INFO - psutil == 3.1.1 22:55:58 INFO - requests == 1.2.3 22:55:58 INFO - wsgiref == 0.1.2 22:55:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:58 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 22:55:58 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 22:55:58 INFO - Using env: {'DISPLAY': ':0', 22:55:58 INFO - 'HOME': '/home/cltbld', 22:55:58 INFO - 'LANG': 'en_US.UTF-8', 22:55:58 INFO - 'LANGUAGE': 'en_US:en', 22:55:58 INFO - 'LOGNAME': 'cltbld', 22:55:58 INFO - 'MAIL': '/var/mail/cltbld', 22:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:58 INFO - 'MOZ_NO_REMOTE': '1', 22:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:58 INFO - 'NO_EM_RESTART': '1', 22:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:58 INFO - 'SHELL': '/bin/bash', 22:55:58 INFO - 'SHLVL': '1', 22:55:58 INFO - 'TERM': 'linux', 22:55:58 INFO - 'TMOUT': '86400', 22:55:58 INFO - 'USER': 'cltbld', 22:55:58 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:58 INFO - '_': '/tools/buildbot/bin/python'} 22:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 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)) 22:55:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:55:58 INFO - Cleaning up... 22:55:58 INFO - Return code: 0 22:55:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:55:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:55:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:55:58 INFO - Using env: {'DISPLAY': ':0', 22:55:58 INFO - 'HOME': '/home/cltbld', 22:55:58 INFO - 'LANG': 'en_US.UTF-8', 22:55:58 INFO - 'LANGUAGE': 'en_US:en', 22:55:58 INFO - 'LOGNAME': 'cltbld', 22:55:58 INFO - 'MAIL': '/var/mail/cltbld', 22:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:58 INFO - 'MOZ_NO_REMOTE': '1', 22:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:55:58 INFO - 'NO_EM_RESTART': '1', 22:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:55:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:55:58 INFO - 'SHELL': '/bin/bash', 22:55:58 INFO - 'SHLVL': '1', 22:55:58 INFO - 'TERM': 'linux', 22:55:58 INFO - 'TMOUT': '86400', 22:55:58 INFO - 'USER': 'cltbld', 22:55:58 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:58 INFO - '_': '/tools/buildbot/bin/python'} 22:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:58 INFO - Downloading/unpacking jsonschema 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:56:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:56:00 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 22:56:00 INFO - Downloading/unpacking functools32 (from jsonschema) 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56:00 INFO - Downloading functools32-3.2.3-2.tar.gz 22:56:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:56:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:56:00 INFO - warning: no files found matching '*.txt' 22:56:00 INFO - no previously-included directories found matching 'build' 22:56:00 INFO - no previously-included directories found matching 'dist' 22:56:00 INFO - no previously-included directories found matching '.git*' 22:56:00 INFO - Installing collected packages: jsonschema, functools32 22:56:00 INFO - Running setup.py install for functools32 22:56:00 INFO - warning: no files found matching '*.txt' 22:56:00 INFO - no previously-included directories found matching 'build' 22:56:00 INFO - no previously-included directories found matching 'dist' 22:56:00 INFO - no previously-included directories found matching '.git*' 22:56:00 INFO - Successfully installed jsonschema functools32 22:56:00 INFO - Cleaning up... 22:56:00 INFO - Return code: 0 22:56:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b0e1e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2101480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, '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-1450936830.767832-1519032560', '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 22:56:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:56:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:56:00 INFO - Using env: {'DISPLAY': ':0', 22:56:00 INFO - 'HOME': '/home/cltbld', 22:56:00 INFO - 'LANG': 'en_US.UTF-8', 22:56:00 INFO - 'LANGUAGE': 'en_US:en', 22:56:00 INFO - 'LOGNAME': 'cltbld', 22:56:00 INFO - 'MAIL': '/var/mail/cltbld', 22:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:00 INFO - 'MOZ_NO_REMOTE': '1', 22:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:00 INFO - 'NO_EM_RESTART': '1', 22:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:56:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:56:00 INFO - 'SHELL': '/bin/bash', 22:56:00 INFO - 'SHLVL': '1', 22:56:00 INFO - 'TERM': 'linux', 22:56:00 INFO - 'TMOUT': '86400', 22:56:00 INFO - 'USER': 'cltbld', 22:56:00 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:00 INFO - '_': '/tools/buildbot/bin/python'} 22:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:56:01 INFO - Downloading/unpacking flake8 22:56:01 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 22:56:01 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 22:56:01 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 22:56:01 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 22:56:01 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 22:56:01 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 22:56:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:56:02 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 22:56:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:56:02 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 22:56:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56:03 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 22:56:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56: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 22:56:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:56:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:56:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:56:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:56:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:56:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:56:03 INFO - no previously-included directories found matching 'docs/_build' 22:56:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:56:03 INFO - Running setup.py install for pep8 22:56:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:56:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:56:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:56:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:56:03 INFO - no previously-included directories found matching 'docs/_build' 22:56:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:56:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:56:03 INFO - Cleaning up... 22:56:03 INFO - Return code: 0 22:56:03 INFO - Running post-action listener: _resource_record_post_action 22:56:03 INFO - Running post-action listener: _start_resource_monitoring 22:56:03 INFO - Starting resource monitoring. 22:56:03 INFO - ##### 22:56:03 INFO - ##### Running install step. 22:56:03 INFO - ##### 22:56:03 INFO - Running pre-action listener: _resource_record_pre_action 22:56:03 INFO - Running main action method: install 22:56:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:56:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:56:03 INFO - Reading from file tmpfile_stdout 22:56:03 INFO - Detecting whether we're running mozinstall >=1.0... 22:56:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:56:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:56:03 INFO - Reading from file tmpfile_stdout 22:56:03 INFO - Output received: 22:56:03 INFO - Usage: mozinstall [options] installer 22:56:03 INFO - Options: 22:56:03 INFO - -h, --help show this help message and exit 22:56:03 INFO - -d DEST, --destination=DEST 22:56:03 INFO - Directory to install application into. [default: 22:56:03 INFO - "/builds/slave/test-pgo"] 22:56:03 INFO - --app=APP Application being installed. [default: firefox] 22:56:03 INFO - mkdir: /builds/slave/test-pgo/build/application 22:56:03 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'] 22:56:03 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 22:56:19 INFO - Reading from file tmpfile_stdout 22:56:19 INFO - Output received: 22:56:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:56:19 INFO - Running post-action listener: _resource_record_post_action 22:56:19 INFO - ##### 22:56:19 INFO - ##### Running run-tests step. 22:56:19 INFO - ##### 22:56:19 INFO - Running pre-action listener: _resource_record_pre_action 22:56:19 INFO - Running main action method: run_tests 22:56:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:56:19 INFO - Python 2.7.3 22:56:19 INFO - Return code: 0 22:56:19 INFO - grabbing minidump binary from tooltool 22:56:19 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')]} 22:56:19 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 0x2190660>, '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 0x2191560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2191a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:56:19 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 22:56:19 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 22:56:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:56:19 INFO - Return code: 0 22:56:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:56:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:56:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:56:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:56:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:56:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:56:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:56:20 INFO - Return code: 0 22:56:20 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/HlB3di1GSRKOWyBV1S4XJw/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 22:56:20 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/HlB3di1GSRKOWyBV1S4XJw/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 22:56:20 INFO - Using env: {'DISPLAY': ':0', 22:56:20 INFO - 'HOME': '/home/cltbld', 22:56:20 INFO - 'LANG': 'en_US.UTF-8', 22:56:20 INFO - 'LANGUAGE': 'en_US:en', 22:56:20 INFO - 'LOGNAME': 'cltbld', 22:56:20 INFO - 'MAIL': '/var/mail/cltbld', 22:56:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:56:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:56:20 INFO - 'MOZ_NO_REMOTE': '1', 22:56:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:56:20 INFO - 'NO_EM_RESTART': '1', 22:56:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:56:20 INFO - 'PWD': '/builds/slave/test-pgo', 22:56:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:56:20 INFO - 'SHELL': '/bin/bash', 22:56:20 INFO - 'SHLVL': '1', 22:56:20 INFO - 'TERM': 'linux', 22:56:20 INFO - 'TMOUT': '86400', 22:56:20 INFO - 'USER': 'cltbld', 22:56:20 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450936830.767832-1519032560', 22:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:56:20 INFO - '_': '/tools/buildbot/bin/python'} 22:56:20 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/HlB3di1GSRKOWyBV1S4XJw/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 22:56:20 INFO - mozversion application_buildid: 20151223203216 22:56:20 INFO - mozversion application_changeset: c3c230a896320099bc14a1ef4b78e41ecc657b1f 22:56:20 INFO - mozversion application_display_name: Nightly 22:56:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:56:20 INFO - mozversion application_name: Firefox 22:56:20 INFO - mozversion application_remotingname: firefox 22:56:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:56:20 INFO - mozversion application_vendor: Mozilla 22:56:20 INFO - mozversion application_version: 46.0a1 22:56:20 INFO - mozversion platform_buildid: 20151223203216 22:56:20 INFO - mozversion platform_changeset: c3c230a896320099bc14a1ef4b78e41ecc657b1f 22:56:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:56:20 INFO - mozversion platform_version: 46.0a1 22:56:20 INFO - using testdate: 1450940180 22:56:20 INFO - actual date: 1450940180 22:56:20 INFO - starting webserver on 'localhost:38053' 22:56:20 INFO - SUITE-START | Running 3 tests 22:56:20 INFO - TEST-START | dromaeo_css 22:56:20 INFO - operating with platform_type : linux_ 22:56:20 INFO - Initialising browser for dromaeo_css test... 22:56:20 INFO - TEST-INFO | started process 20320 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpptf0JK/profile http://localhost:38053/getInfo.html) 22:56:25 INFO - PROCESS | 20320 | __metrics Screen width/height:1600/1200 22:56:25 INFO - PROCESS | 20320 | colorDepth:24 22:56:25 INFO - PROCESS | 20320 | Browser inner width/height: 1024/697 22:56:25 INFO - PROCESS | 20320 | __metrics 22:56:25 INFO - PROCESS | 20320 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:56:26 INFO - TEST-INFO | 20320: exit 0 22:56:26 INFO - Browser initialized. 22:56:26 INFO - Running cycle 1/1 for dromaeo_css test... 22:56:26 INFO - TEST-INFO | started process 20452 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpptf0JK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:56:38 INFO - PROCESS | 20452 | RSS: Main: 149680128 22:56:38 INFO - PROCESS | 20452 | 22:57:28 INFO - PROCESS | 20452 | 1450940248081 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] 22:59:37 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38053/tests/dromaeo/cssquery-ext.html) 22:59:38 INFO - PROCESS | 20452 | RSS: Main: 159612928 22:59:38 INFO - PROCESS | 20452 | 23:02:40 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-ext.html (next: http://localhost:38053/tests/dromaeo/cssquery-jquery.html) 23:02:41 INFO - PROCESS | 20452 | RSS: Main: 152813568 23:02:41 INFO - PROCESS | 20452 | 23:05:43 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38053/tests/dromaeo/cssquery-mootools.html) 23:05:43 INFO - PROCESS | 20452 | RSS: Main: 154497024 23:05:43 INFO - PROCESS | 20452 | 23:08:45 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38053/tests/dromaeo/cssquery-prototype.html) 23:08:45 INFO - PROCESS | 20452 | RSS: Main: 152371200 23:08:45 INFO - PROCESS | 20452 | 23:11:48 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38053/tests/dromaeo/cssquery-yui.html) 23:11:48 INFO - PROCESS | 20452 | RSS: Main: 151535616 23:11:48 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | Cycle 1(1): loaded http://localhost:38053/tests/dromaeo/cssquery-yui.html (next: http://localhost:38053/tests/dromaeo/cssquery-dojo.html) 23:14:51 INFO - PROCESS | 20452 | RSS: Main: 154861568 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | __start_tp_report 23:14:51 INFO - PROCESS | 20452 | _x_x_mozilla_page_load 23:14:51 INFO - PROCESS | 20452 | _x_x_mozilla_page_load_details 23:14:51 INFO - PROCESS | 20452 | |i|pagename|runs| 23:14:51 INFO - PROCESS | 20452 | |0;dojo.html;3163.0194639661704;3183.411068952244;3220.4686226772583;3222.903312900613;3239.6760323967605;5269.578433725303;5368.114261146911;5422.05114105032;5425;5426.864328391787;5350.170723537848;5360;5380.408155102936;5398.595105367103;5404.054290499166;4652.302154676809;4934.80260789568;5091.541761241488;5106.69359838409;5136.794528218867;4815.0610630926985;5033.370828646419;5049.545540901318;5095.719735414551;5114.897702045957;4804.135255653999;4878.902421951577;4879.682820616648;4897;4916.7295798730875;4941;4949.109160351135;4966.5778408835295;4992.700437973734;5001.099802035632;4849.272609108627;4891.755412229374;4910.533499317559;4941.678790878582;4979.975100124512;5064.721440320781;5168.069747445458;5220.712860792655;5226.973865130688;5236.214567814858;5796.449337312949;5811.302643682743;5819.214406055213;5839.386864379264;5850.444207800252;5730.885382292373;5785.190073389729;5801.7389217485315;5840.8247752567495;5866.120081987693;5351.732413379315;5399.946000540023;5403.8108666196495;5412.944475827216;5413.702246376409;5846.824595262149;5905.734241959122;5915.08316210988;5920.674362910081;5920.79277225295;5700.543956483471;5701.629394089371;5703.287089113861;5706.3722990471015;5715.5427565794635;5761.222234998306;5785.71071446426;5793.623414478046;5806.2451881255165;5806.622569532967;5711;5746.109353050284;5750.511206547407;5751.539876809845;5774;5695.7152142392715;5736.6558006519745;5765.538756899438;5797.101449275369;5816.040353341736;4434.357018232403;4449.621782148489;4458.398116254329;4469.396631454777;4492.101579684077;3906.1797022625565;4037.7779222142476;4043.1913617276664;4043.4339192512484;4094.2220978014084;5398.595105367113;5406.83779486616;5408.648437851527;5410.458954104637;5410.540104091197;5742.13867919807;5797.24635797352;5803.680797556175;5821.825345239649;5853.64878107315;5464.672119672753;5468.7265636718;5472.042392581282;5474.671519708831;5480.123180291134;4960.578350840146;5038.5969122470115;5048.570871475966;5053.747312634354;5091.9236211456855;5915.112733089984;5965.224520812267;5968.22413086296;5990.161377407167;6042.788502402483;5800.622959507618;5822.534197264294;5824.3593204748295;5827.9417205829095;5836.9416305838095;5850.882982340415;5906.143609176731;5979.910301345571;6009.549283803644;6028.367021462684;5685;5702.942970570241;5716.228309178207;5718.857028574319;5759.596828222152;5794.82615521535;5813.418658134322;5843.415658434293;5844.211031510692;5866.120081987736;5633.746481408429;5712.11462223356;5713.942860571341;5723.341815691082;5763.221965034834;5607.158926161109;5680.573956953162;5754.510866576388;5763;5817.592768506164;5530.889382212414;5555.611107222456;5563.05428077236;5566.053770859045;5606.551475881838;5578.330600327987;5595.608307418442;5658.094704847204;5678.176664383724;5697.344805347272;5508.807191748269;5544.7782088716;5560.249366335493;5569.749361278671;5637.887242255214 23:14:51 INFO - PROCESS | 20452 | |1;ext.html;559.6997463568038;569.345252959097;581.3866370978618;615.2371059885741;617.5183356981556;35886.99999999997;36588.45117323239;36755.44866827;37006.25987480249;37070.44394334087;41570.58429415705;42140.789296053554;42360;42433.7878310608;42578;8824.691135810264;8961.372703910729;8993.100689930987;9015.053419390968;9019.413738107001;8684.13158684133;8724;8786.736397908073;8798.51608161554;8800.251978581828;8802.07578204289;8815.911840881605;8880.689175878813;8882.822343553125;8892.688755893545;8790.6923257686;8811.251043661296;8856.601452934568;8879.422837515542;8893.911060889406;8555.10171431997;8665.870011949826;8666.220040196413;8666.566671666455;8672.869906951337;39626.20747585061;40035.19929601392;40173.59826401757;40176.79911600423;40294;3241.222106694376;3256.9185770355693;3281.2453135778665;3392.796432214075;4012.2376748417705;29471.26321841971;29965.25086872824;30463.23841903948;30619.540706889413;31170.844145779352;3703.518542589473;3725.0873535983587;3785.1483416231404;3806.448065030555;3847.03824043989;263310;263313;263499.6825015882;263530;263824;54342.18486722702;54990.87568432384;59481.70259148676;59861;62320.68839655773;57015.714921425126;57250.141247881314;57367.71316143392;57503.71248143816;57565.42434575601;14667.413303467742;14771;14892.106473611619;14923.626909327353;14945.775813362809;11982.58060967862;12036.338001409831;12083.697907552205;12104.87895121055;12108.455119519644;20435.080421381073;20749.89625051865;20874.47813804637;21067.789322106582;21086.789132108788;7545.396368290523;7728.227177282227;7809.3752499799875;7835.921640783519;7867.331276841418;988.2983082011708;1021.6117875207374;1021.7241344836852;1068.391017120234;1073.4579037586125;25691.229263122135;27234.863825680746;27241.86379068092;27313.86343068272;27406.314842129108;1029.9897001030045;1046.0742243114898;1061.4533515239657;1099.796537640523;1141.6137589794018;15125.773113403307;15522.922385388001;15667.843321566867;15792.842071579136;15964.281607327699;336906;337785;338574;340019;340938;45215.547844521134;45504.317435238496;45775;45806.31290530645;46018.30972535415;1360.3946243921557;1369.5343583181766;1370.8492065872547;1371.4788380415378;1373.8694823991705;25648.487030259665;26640.33399164959;26988.73011269862;27015.459690806467;27930.441391171655;43632;43872.56127438685;44163.77918110389;44187.77906110449;44313.77843110764;255719;255999;256698;256799;257158;31171.37657246797;32424.837875811412;32534;32829.045385915386;32964;38432.2313553733;38986.6101338983;39420.40869387019;39601.405978910916;40648;33524.66475335313;36529.63470365262;36667.81666091653;36926.89219323425;37167.442488362154;33602;33753.493697594065;33798.32403351968;34075.31849362949;36178.8191059043;32806.34387312193;32826.67173328236;33288.50067248945;33422.16444588808;33467.33065338728;29942.25144371408;30330.69669303367;30456.695433045385;31045.68954310428;31551.84224078865;24553.75446245515;24643;24999.87500062488;25201.873990630662;25269.87365063163 23:14:51 INFO - PROCESS | 20452 | |2;jquery.html;343.9037069620507;344.411057092372;346.2227299712145;346.6464206509361;348.0723870884094;16173.353065877365;16710.24803883825;17821.465356039305;17931.193096310664;18450.354237601685;11486.770264594703;12981.675458113528;16070.517884463485;16076.196190190472;16102.436414725487;4644.3962284903;5605.495505404513;5636.859078523049;5640.605157638967;5643.943560564403;5448.700321482317;5578.804741834037;5626.465485778845;5627.634203776762;5638.238837756891;4489.663275254369;5111.565516931066;5243.68537887728;5553.333599968009;5561.833145005657;5294.735263236861;5310.15037593985;5331.120365139747;5354.785808567672;5356.464353564651;5194.844154675366;5428.972855135738;5458.426865179139;5462.562994960434;5474.616776825624;13032;13186.86813131866;13280.07039507235;13522.12106213103;13558.525451609245;2127.2022991378235;2130.637791575436;2147.5382792699643;2154.3859999899955;2205.8125059369972;9186.586603602787;9540.045995400475;9617.90382096177;9735.951320243425;10185.236107291983;1773.866959978007;1828.9176987035614;1864.7016477363693;1873.8313551780268;1935.3516571948273;54427.45572544263;58138.127928081114;63567.04649430262;64297.35702642961;64926;10442.2168337375;10496.317739346918;10529.05238528536;10583.62957296491;10608.787824243473;13577.11748736329;13580.185188888698;13594.796078058836;13604.795928061087;13644.386002629906;7371.705131794668;7484.775456736306;7515.421761430051;7537.2085930977555;7538.736144234926;7126.6080365579355;7181.3177748114895;7189.388901943289;7206.423486121098;7228.31331023552;4491.595756381941;4582.152301824173;4588.990422107197;4598.2412901871485;4599.126166028444;1850.731643911652;1881.200489791833;1881.9341323053627;1887.877287976277;1932.9226830926605;425.84669518973146;425.9850905218305;428.4858170195715;438.7806096951524;446.6359916667905;10937.617183398543;11456.312621242752;11577.421128943519;11579.826302605468;11705.063594912386;923.9445633262026;932.9533523323806;968.8740463739668;975.6975337645353;1025.43601019439;9055.320850936207;9243.075692430837;9256.166944974984;9286.535673216447;9328.253739700807;514289;520777;522709;542733;545726;45758.771206144425;76468;78675;84276.57861710775;84553.35762883886;1158.073541167063;1179.292424545266;1180.0972256223995;1197.5389475051993;1204.5723768062387;16352.345906164097;16439;16444.424445144363;16456.917715411826;16558.254878530253;35248.11879702925;35480.64519354773;35775.60131787476;36016.459753104245;37312.81343593264;48564.75717621389;52106.739466302424;53151.734241328544;53256;54882;8846.203841654282;9666.806663866824;9895.158911492605;9927.652532161339;10026.949865250626;10945.179111566824;10960.945195273973;11056.889431105908;11135.72160695989;11140.888591113986;13062.477500900237;14046.578602641937;14512.85487145115;14874.553763387115;15007.024543404645;13854.584362469142;14057.929710351384;14394;14401.63995900111;14744.852551474349;14489.927550362603;14598.854011459749;14769.335379908145;14770.409183632535;14866.405343786128;9751.609935602497;9822.803543928938;9855.35940163887;9869.25980551476;9899.703008909744;10758.838617420588;12233;14323.14061156334;14609.342579584158;15244.618884527976 23:14:51 INFO - PROCESS | 20452 | |3;mootools.html;1452.2448326870026;1498.1535432480648;1606.3092870065882;1629.6170399956015;1765.5497848048753;6594.538382313234;6799.796006119812;6982.476314276424;7070.717171313147;7103.147622285326;7043.894341584867;7071.0807595012575;7108.289171082889;7127.928720712791;7143.107111611049;2210.160139147126;2229.698990636268;2243.2372993182316;2252.966205506919;2255.0528777913314;2167.2739632223224;2184.2246002669062;2247.550489902018;2248.0895237428867;2249.4263962689492;2194.8353873459555;2216.6785816056663;2229.8996545155505;2242.988785056081;2255.289583781104;2237.8545394549383;2258.3902346366554;2271.250487339174;2272.545490901818;2273.1702928431087;2214.5903007943584;2254.402583315423;2259.1302348595746;2260.1298500077587;2261.8190544756544;6930.93069069313;6958.8956165657555;7001.719931202746;7012.439004879649;7019.859602807966;4414.911701765946;4473.932891006638;4479.70881892676;4491.820327186909;4503.392042074311;2948.1303015610447;2984.8358340291275;3000.3699223162944;3003.6245469316336;3016.3364059906785;992.3896803465889;1008.2992320337369;1009.9040591143829;1026.938383696973;1059.5814653211937;8965;9059;9065.229455496357;9075.273978081737;9091.13634204756;3891.747036442622;3924.430957511202;3953.0512676957896;3959.7228194026143;3999.0802115513593;7511.286427789351;7565.546067235983;7610.315071643578;7652.349550288288;7653.119891212582;4354.521002689701;4360.542143074995;4388.29787234041;4395.648348132142;4401.559844015573;4020.597940205956;4042.5957404259925;4050.5949405059846;4058.7564746115327;4078.388241763759;3286.1291757684235;3287.5561799157285;3303.4714445688574;3333.5666363372607;3334.549835772188;1028.8456731490187;1029.7940411917496;1037.7924415117006;1043.4782608695652;1046.576136664652;1039.3763741754888;1042.3120740311358;1102.9962733912103;1190.898773604236;1292.4119525615822;6692.631905245161;6717.328267173243;6771.966140169267;6782.660866956632;6796.626185559841;1088.4992903264429;1109.362116782853;1114.6823155400673;1124.9775004500027;1129.1474936423112;5338.306020217425;5340.49265319794;5361.973190134102;5363.919541206885;5377.7311134443125;7924.920750792534;8099.554524501091;8150.75547733569;8327.375446841512;8367;8063.193680632007;8108;8140.75577732669;8164;8208.917910820936;6255.874882502416;6516;6570.835729106715;6586.1438013058;6596.142501474777;6619.172603424572;6644.667766611554;6676.165479315086;6676.732930682912;6686.06395104676;7312.744053958086;7453.478256521991;7476.626168691652;7556.206598307099;7560.697572097055;7522.097348318237;7576.962115189389;7589.848203035798;7598.544087354777;7621.923780762121;6345.746170153142;6365.52258580599;6380.904286435614;6387.073874288295;6421.1010458536775;6671.26616072222;6685.231198412245;6802.251752307143;6825;6826.556273842184;6282.246130464374;6361.809145725636;6403;6540.967295163494;6588.209414870246;5671.489565939085;6131.877362452815;6225.533085018551;6230.6884655767935;6373.7131829066875;6127.356627554221;6129.509639228761;6136.754529818936;6153.169322141453;6167.6916154193;5815.709214539172;5817.127430885232;5829.417058294137;5837.066069428871;5869.6771677558145;5799.130130480462;5972;5982.850428739316;5995.6702381367695;6019.398060193946 23:14:51 INFO - PROCESS | 20452 | |4;prototype.html;331.4183607768366;335.27413150529105;343.7593684420906;346.2434580441735;349.37461943121815;6251.656158911258;6303.464205542528;6386.64873431961;6389.1055252264605;6423.678816059196;6101.389861013897;6267.843303917404;6269;6273.466755325791;6280.591761535497;4816.44610869751;4831.347768051303;4834.685745426554;4835.709857408549;4841.370621819158;4831.541003604652;4836.298736683197;4841.443234028096;4842.636802239828;4850.781714822824;4726.432828060638;4806.4472585652575;4809.374781278429;4822.6624136310475;4824.734639594821;4797.544233297866;4798.184308667517;4800.063987522434;4809.903801923977;4810.326554282403;4194.28697121487;4214.515330736974;4215.557366476537;4221.366794980747;4224.302990006645;5932.169496270526;5974.4921681657115;5975.641461512279;5980.730867110947;5999.850003749898;5462.6995515246645;5638.774449022034;5641.915371269434;5644.4073372295725;5655.830325090254;6718.05947167397;6724.731010759564;6730.226024007204;6734.461243100589;6734.8989765153565;4666.626669866437;4668.276417155346;4672.859814205579;4674.532546745332;4678.672492925497;6896;7051.153861536597;7057.153141622986;7098.396636285922;7112.786616401516;4703.576678098988;4731.952680473151;4734.621230301636;4735.502772208937;4735.83424580138;4799.760011999386;4800.567948884547;4801.231802911588;4807.591354734886;4812.639052071108;5575.303087114111;5580.135079062752;5583.106702927512;5595;5605.019121653694;6540.934590654033;6797.626130562768;6815.829604259933;6816.829579260459;6835.555688880307;1655.329591515438;1681.638447733743;1686.53620254431;1690.2562872336132;1692.9830701693072;1099.1371773158032;1113.4098927568402;1117.1286396610656;1119.1326721790676;1124.2916962313855;6330.987042073246;6341.873162536724;6348.079528468438;6357.872842543124;6369.20384951881;6889.965550172317;6919.481038922101;6925.203601585781;6928.722851086001;6934.271901450275;6225.533085018551;6286.4342209201395;6328.17733694626;6328.905066424008;6342.778002769973;3756.981215093907;3813.2182902505474;3836.8848934532007;3838.846446142123;3845.5962123977138;7406.07424071991;7434.070741157356;7436.739714110088;7437.702491900263;7447.776566703008;7019.192792828788;7231.674574644154;7235.131784185826;7256.346928776436;7262.963685181646;7356.595387253646;7391.33477986973;7391.85216295671;7393.667284972189;7403.444741644398;6968.407685346802;7007.299270073156;7011.929880701332;7011.964940175267;7028.367446929801;6797.89803152963;6939.340762627542;6955.826104347432;6958.269381714847;6965.825854353681;7349.118105827335;7355.632218389166;7371.889421658572;7389.630518474162;7402.444816638881;4706;4752.9287060694805;4758.785854636619;4765.8570242892765;4783.115123702126;6853.554518956252;6876.553024053421;7049.859002819812;7057.788266352018;7079;6854.588724676535;6877.793666190022;6881.243063263138;6887.345702158287;6898.965505172442;6744.69648865812;6818.318168183142;6820.863582728219;6836.38472537474;6841.521093523605;6604.7027883746305;6713.832154196184;6723.966380168068;6731.124953755981;6742.157230346207;6830.077939478306;6877.759278425231;6888.655567221719;6895.862082758216;6903.792886213421;6660.467162626881;6689.899651505134;6695.263521012587;6699.263081060982;6735.191776986793 23:14:51 INFO - PROCESS | 20452 | |5;yui.html;714.1893950366334;718.5832217313958;756.6141267953342;774.4462709162948;803.5982008995502;12659.936700316497;12831;12966.870331296685;12980.221186728779;12986.350682465874;11388.430578471063;12054.276743395403;12234.510619575229;12247.632571022861;12335.19821211623;789.6801795272924;793.5754371411296;802.8033131882697;809.4778867630375;822.7326119011316;786.0096278688865;799.1050023973129;801.5311043039828;805.1505661527086;826.1408135539062;831.9584020798966;835.2524490580927;838.4801423117646;839.1398816213369;867.4795122926257;829.1045670675655;829.324100857802;835.8913341265596;840.3277378097528;872.2978002707817;605.5972778102556;605.9636421814705;609.5793902207507;616.2851092732409;638.0047126482656;12169.93915030428;12320.459942507186;12364.381780910919;12400.00799936003;12422.875771242263;11026.44867756609;11028.22802403832;11200;11263.774724505545;11567.942160289229;9853;9976.251781116373;9976.600935962553;10169.949150254275;10273.743156421075;3558.857645694169;3594.6405359464106;3631.963680363189;3632.5640923089136;3646.74472786905;45208.99999999967;45212.77393613011;48333;48404.27393589099;48424.51575484271;9288.071192880658;9354.551902578309;9596;9688.224942004623;10006.349587276804;17703.73444398335;17749.66877484194;17913.641727165385;17921.641567168583;17971.101444927703;7592.202818703957;7727.227277272228;7736.6518506667335;7769.6115194240065;7945.64244608994;4384.890377740582;4403.471583410012;4450.577195166454;4453.821847126079;4520.095980803852;3106.3631955449077;3107.254258977874;3110.12916383413;3128.8592013359453;3137.074563003919;544.3196004993757;561.6630021986775;568.5792513539951;569.6724383479516;573.8938296415176;648.3322178156507;673.8039979037248;688.3220028272148;712.5617745086838;752.0862152484757;8343.123971982975;8787.736367908972;8847.867281990775;8992;9056;577.644748479682;655.3512023097195;679.1171477079777;684.1516519515765;687.6767919078026;4053.8043125365107;4260.488741351058;4312.504062032844;4328.156009578165;4356.891077723082;65432.34567654358;65638;65985;66424.66787666031;66617.66691166513;49361.753191233816;49524.009519810126;53394.73302633462;54576.72711636416;55104.448955510736;47343.5265647346;49398.753006234736;49604.75197623989;50446.49553504418;50730.49269507331;8178.386621003568;8514.659413623385;8764.693235736719;8794.91205087941;8884.73345799627;36267;36304.63695363013;36746.63253367432;36925.63074369329;37285;45488;48665;48756.756216218695;48943.75528122479;49067.263991040876;10822.188335874998;11374.374409407232;11382.715432113931;11450.225215091674;11617.477213525242;12251.326177059991;12494.625161245178;12821.743565128832;12973.286469243905;13016.15394999322;10983.725406864893;11071.501782419971;11156.609518666808;11763.117766167401;11995.64013079609;11333.489992950503;11643.359615220905;11690.76618467609;11958.282503049844;12346.444410001392;11367.715807104889;11502.367369794407;11591.536338546364;11670.241434306743;11827.290362577929;9911.752206194902;10267.435291059064;10409.68770936873;10604.522796474332;10648.094911932572;9454.385464944757;9554.61781528759;9601.471919044241;9916.157126644315;10072.345297555636 23:14:51 INFO - PROCESS | 20452 | __end_tp_report 23:14:51 INFO - PROCESS | 20452 | __start_cc_report 23:14:51 INFO - PROCESS | 20452 | _x_x_mozilla_cycle_collect,313 23:14:51 INFO - PROCESS | 20452 | __end_cc_report 23:14:51 INFO - PROCESS | 20452 | __startTimestamp1450941291400__endTimestamp 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | ------- Summary: start ------- 23:14:51 INFO - PROCESS | 20452 | Number of tests: 6 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#0] dojo.html Cycles:165 Average:5380.66 Median:5569.75 stddev:593.00 (10.6%) stddev-sans-first:568.73 23:14:51 INFO - PROCESS | 20452 | Values: 3163.0 3183.4 3220.5 3222.9 3239.7 5269.6 5368.1 5422.1 5425.0 5426.9 5350.2 5360.0 5380.4 5398.6 5404.1 4652.3 4934.8 5091.5 5106.7 5136.8 4815.1 5033.4 5049.5 5095.7 5114.9 4804.1 4878.9 4879.7 4897.0 4916.7 4941.0 4949.1 4966.6 4992.7 5001.1 4849.3 4891.8 4910.5 4941.7 4980.0 5064.7 5168.1 5220.7 5227.0 5236.2 5796.4 5811.3 5819.2 5839.4 5850.4 5730.9 5785.2 5801.7 5840.8 5866.1 5351.7 5399.9 5403.8 5412.9 5413.7 5846.8 5905.7 5915.1 5920.7 5920.8 5700.5 5701.6 5703.3 5706.4 5715.5 5761.2 5785.7 5793.6 5806.2 5806.6 5711.0 5746.1 5750.5 5751.5 5774.0 5695.7 5736.7 5765.5 5797.1 5816.0 4434.4 4449.6 4458.4 4469.4 4492.1 3906.2 4037.8 4043.2 4043.4 4094.2 5398.6 5406.8 5408.6 5410.5 5410.5 5742.1 5797.2 5803.7 5821.8 5853.6 5464.7 5468.7 5472.0 5474.7 5480.1 4960.6 5038.6 5048.6 5053.7 5091.9 5915.1 5965.2 5968.2 5990.2 6042.8 5800.6 5822.5 5824.4 5827.9 5836.9 5850.9 5906.1 5979.9 6009.5 6028.4 5685.0 5702.9 5716.2 5718.9 5759.6 5794.8 5813.4 5843.4 5844.2 5866.1 5633.7 5712.1 5713.9 5723.3 5763.2 5607.2 5680.6 5754.5 5763.0 5817.6 5530.9 5555.6 5563.1 5566.1 5606.6 5578.3 5595.6 5658.1 5678.2 5697.3 5508.8 5544.8 5560.2 5569.7 5637.9 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#1] ext.html Cycles:180 Average:45128.47 Median:187047.16 stddev:75449.39 (40.3%) stddev-sans-first:75586.84 23:14:51 INFO - PROCESS | 20452 | Values: 559.7 569.3 581.4 615.2 617.5 35887.0 36588.5 36755.4 37006.3 37070.4 41570.6 42140.8 42360.0 42433.8 42578.0 8824.7 8961.4 8993.1 9015.1 9019.4 8684.1 8724.0 8786.7 8798.5 8800.3 8802.1 8815.9 8880.7 8882.8 8892.7 8790.7 8811.3 8856.6 8879.4 8893.9 8555.1 8665.9 8666.2 8666.6 8672.9 39626.2 40035.2 40173.6 40176.8 40294.0 3241.2 3256.9 3281.2 3392.8 4012.2 29471.3 29965.3 30463.2 30619.5 31170.8 3703.5 3725.1 3785.1 3806.4 3847.0 263310.0 263313.0 263499.7 263530.0 263824.0 54342.2 54990.9 59481.7 59861.0 62320.7 57015.7 57250.1 57367.7 57503.7 57565.4 14667.4 14771.0 14892.1 14923.6 14945.8 11982.6 12036.3 12083.7 12104.9 12108.5 20435.1 20749.9 20874.5 21067.8 21086.8 7545.4 7728.2 7809.4 7835.9 7867.3 988.3 1021.6 1021.7 1068.4 1073.5 25691.2 27234.9 27241.9 27313.9 27406.3 1030.0 1046.1 1061.5 1099.8 1141.6 15125.8 15522.9 15667.8 15792.8 15964.3 336906.0 337785.0 338574.0 340019.0 340938.0 45215.5 45504.3 45775.0 45806.3 46018.3 1360.4 1369.5 1370.8 1371.5 1373.9 25648.5 26640.3 26988.7 27015.5 27930.4 43632.0 43872.6 44163.8 44187.8 44313.8 255719.0 255999.0 256698.0 256799.0 257158.0 31171.4 32424.8 32534.0 32829.0 32964.0 38432.2 38986.6 39420.4 39601.4 40648.0 33524.7 36529.6 36667.8 36926.9 37167.4 33602.0 33753.5 33798.3 34075.3 36178.8 32806.3 32826.7 33288.5 33422.2 33467.3 29942.3 30330.7 30456.7 31045.7 31551.8 24553.8 24643.0 24999.9 25201.9 25269.9 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#2] jquery.html Cycles:180 Average:28086.68 Median:35896.03 stddev:86572.05 (241.2%) stddev-sans-first:86789.84 23:14:51 INFO - PROCESS | 20452 | Values: 343.9 344.4 346.2 346.6 348.1 16173.4 16710.2 17821.5 17931.2 18450.4 11486.8 12981.7 16070.5 16076.2 16102.4 4644.4 5605.5 5636.9 5640.6 5643.9 5448.7 5578.8 5626.5 5627.6 5638.2 4489.7 5111.6 5243.7 5553.3 5561.8 5294.7 5310.2 5331.1 5354.8 5356.5 5194.8 5429.0 5458.4 5462.6 5474.6 13032.0 13186.9 13280.1 13522.1 13558.5 2127.2 2130.6 2147.5 2154.4 2205.8 9186.6 9540.0 9617.9 9736.0 10185.2 1773.9 1828.9 1864.7 1873.8 1935.4 54427.5 58138.1 63567.0 64297.4 64926.0 10442.2 10496.3 10529.1 10583.6 10608.8 13577.1 13580.2 13594.8 13604.8 13644.4 7371.7 7484.8 7515.4 7537.2 7538.7 7126.6 7181.3 7189.4 7206.4 7228.3 4491.6 4582.2 4589.0 4598.2 4599.1 1850.7 1881.2 1881.9 1887.9 1932.9 425.8 426.0 428.5 438.8 446.6 10937.6 11456.3 11577.4 11579.8 11705.1 923.9 933.0 968.9 975.7 1025.4 9055.3 9243.1 9256.2 9286.5 9328.3 514289.0 520777.0 522709.0 542733.0 545726.0 45758.8 76468.0 78675.0 84276.6 84553.4 1158.1 1179.3 1180.1 1197.5 1204.6 16352.3 16439.0 16444.4 16456.9 16558.3 35248.1 35480.6 35775.6 36016.5 37312.8 48564.8 52106.7 53151.7 53256.0 54882.0 8846.2 9666.8 9895.2 9927.7 10026.9 10945.2 10960.9 11056.9 11135.7 11140.9 13062.5 14046.6 14512.9 14874.6 15007.0 13854.6 14057.9 14394.0 14401.6 14744.9 14489.9 14598.9 14769.3 14770.4 14866.4 9751.6 9822.8 9855.4 9869.3 9899.7 10758.8 12233.0 14323.1 14609.3 15244.6 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#3] mootools.html Cycles:180 Average:4948.82 Median:5920.84 stddev:2412.35 (40.7%) stddev-sans-first:2404.80 23:14:51 INFO - PROCESS | 20452 | Values: 1452.2 1498.2 1606.3 1629.6 1765.5 6594.5 6799.8 6982.5 7070.7 7103.1 7043.9 7071.1 7108.3 7127.9 7143.1 2210.2 2229.7 2243.2 2253.0 2255.1 2167.3 2184.2 2247.6 2248.1 2249.4 2194.8 2216.7 2229.9 2243.0 2255.3 2237.9 2258.4 2271.3 2272.5 2273.2 2214.6 2254.4 2259.1 2260.1 2261.8 6930.9 6958.9 7001.7 7012.4 7019.9 4414.9 4473.9 4479.7 4491.8 4503.4 2948.1 2984.8 3000.4 3003.6 3016.3 992.4 1008.3 1009.9 1026.9 1059.6 8965.0 9059.0 9065.2 9075.3 9091.1 3891.7 3924.4 3953.1 3959.7 3999.1 7511.3 7565.5 7610.3 7652.3 7653.1 4354.5 4360.5 4388.3 4395.6 4401.6 4020.6 4042.6 4050.6 4058.8 4078.4 3286.1 3287.6 3303.5 3333.6 3334.5 1028.8 1029.8 1037.8 1043.5 1046.6 1039.4 1042.3 1103.0 1190.9 1292.4 6692.6 6717.3 6772.0 6782.7 6796.6 1088.5 1109.4 1114.7 1125.0 1129.1 5338.3 5340.5 5362.0 5363.9 5377.7 7924.9 8099.6 8150.8 8327.4 8367.0 8063.2 8108.0 8140.8 8164.0 8208.9 6255.9 6516.0 6570.8 6586.1 6596.1 6619.2 6644.7 6676.2 6676.7 6686.1 7312.7 7453.5 7476.6 7556.2 7560.7 7522.1 7577.0 7589.8 7598.5 7621.9 6345.7 6365.5 6380.9 6387.1 6421.1 6671.3 6685.2 6802.3 6825.0 6826.6 6282.2 6361.8 6403.0 6541.0 6588.2 5671.5 6131.9 6225.5 6230.7 6373.7 6127.4 6129.5 6136.8 6153.2 6167.7 5815.7 5817.1 5829.4 5837.1 5869.7 5799.1 5972.0 5982.9 5995.7 6019.4 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#4] prototype.html Cycles:180 Average:5653.94 Median:6329.95 stddev:1731.09 (27.3%) stddev-sans-first:1689.22 23:14:51 INFO - PROCESS | 20452 | Values: 331.4 335.3 343.8 346.2 349.4 6251.7 6303.5 6386.6 6389.1 6423.7 6101.4 6267.8 6269.0 6273.5 6280.6 4816.4 4831.3 4834.7 4835.7 4841.4 4831.5 4836.3 4841.4 4842.6 4850.8 4726.4 4806.4 4809.4 4822.7 4824.7 4797.5 4798.2 4800.1 4809.9 4810.3 4194.3 4214.5 4215.6 4221.4 4224.3 5932.2 5974.5 5975.6 5980.7 5999.9 5462.7 5638.8 5641.9 5644.4 5655.8 6718.1 6724.7 6730.2 6734.5 6734.9 4666.6 4668.3 4672.9 4674.5 4678.7 6896.0 7051.2 7057.2 7098.4 7112.8 4703.6 4732.0 4734.6 4735.5 4735.8 4799.8 4800.6 4801.2 4807.6 4812.6 5575.3 5580.1 5583.1 5595.0 5605.0 6540.9 6797.6 6815.8 6816.8 6835.6 1655.3 1681.6 1686.5 1690.3 1693.0 1099.1 1113.4 1117.1 1119.1 1124.3 6331.0 6341.9 6348.1 6357.9 6369.2 6890.0 6919.5 6925.2 6928.7 6934.3 6225.5 6286.4 6328.2 6328.9 6342.8 3757.0 3813.2 3836.9 3838.8 3845.6 7406.1 7434.1 7436.7 7437.7 7447.8 7019.2 7231.7 7235.1 7256.3 7263.0 7356.6 7391.3 7391.9 7393.7 7403.4 6968.4 7007.3 7011.9 7012.0 7028.4 6797.9 6939.3 6955.8 6958.3 6965.8 7349.1 7355.6 7371.9 7389.6 7402.4 4706.0 4752.9 4758.8 4765.9 4783.1 6853.6 6876.6 7049.9 7057.8 7079.0 6854.6 6877.8 6881.2 6887.3 6899.0 6744.7 6818.3 6820.9 6836.4 6841.5 6604.7 6713.8 6724.0 6731.1 6742.2 6830.1 6877.8 6888.7 6895.9 6903.8 6660.5 6689.9 6695.3 6699.3 6735.2 23:14:51 INFO - PROCESS | 20452 | 23:14:51 INFO - PROCESS | 20452 | [#5] yui.html Cycles:180 Average:14222.47 Median:48710.88 stddev:17083.55 (35.1%) stddev-sans-first:17101.36 23:14:51 INFO - PROCESS | 20452 | Values: 714.2 718.6 756.6 774.4 803.6 12659.9 12831.0 12966.9 12980.2 12986.4 11388.4 12054.3 12234.5 12247.6 12335.2 789.7 793.6 802.8 809.5 822.7 786.0 799.1 801.5 805.2 826.1 832.0 835.3 838.5 839.1 867.5 829.1 829.3 835.9 840.3 872.3 605.6 606.0 609.6 616.3 638.0 12169.9 12320.5 12364.4 12400.0 12422.9 11026.4 11028.2 11200.0 11263.8 11567.9 9853.0 9976.3 9976.6 10169.9 10273.7 3558.9 3594.6 3632.0 3632.6 3646.7 45209.0 45212.8 48333.0 48404.3 48424.5 9288.1 9354.6 9596.0 9688.2 10006.3 17703.7 17749.7 17913.6 17921.6 17971.1 7592.2 7727.2 7736.7 7769.6 7945.6 4384.9 4403.5 4450.6 4453.8 4520.1 3106.4 3107.3 3110.1 3128.9 3137.1 544.3 561.7 568.6 569.7 573.9 648.3 673.8 688.3 712.6 752.1 8343.1 8787.7 8847.9 8992.0 9056.0 577.6 655.4 679.1 684.2 687.7 4053.8 4260.5 4312.5 4328.2 4356.9 65432.3 65638.0 65985.0 66424.7 66617.7 49361.8 49524.0 53394.7 54576.7 55104.4 47343.5 49398.8 49604.8 50446.5 50730.5 8178.4 8514.7 8764.7 8794.9 8884.7 36267.0 36304.6 36746.6 36925.6 37285.0 45488.0 48665.0 48756.8 48943.8 49067.3 10822.2 11374.4 11382.7 11450.2 11617.5 12251.3 12494.6 12821.7 12973.3 13016.2 10983.7 11071.5 11156.6 11763.1 11995.6 11333.5 11643.4 11690.8 11958.3 12346.4 11367.7 11502.4 11591.5 11670.2 11827.3 9911.8 10267.4 10409.7 10604.5 10648.1 9454.4 9554.6 9601.5 9916.2 10072.3 23:14:51 INFO - PROCESS | 20452 | -------- Summary: end -------- 23:14:51 INFO - PROCESS | 20452 | 23:14:52 INFO - TEST-INFO | 20452: exit 0 23:14:52 INFO - TEST-OK | dromaeo_css | took 1111150ms 23:14:52 INFO - TEST-START | kraken 23:14:52 INFO - operating with platform_type : linux_ 23:14:52 INFO - Initialising browser for kraken test... 23:14:52 INFO - TEST-INFO | started process 20692 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplXaEqt/profile http://localhost:38053/getInfo.html) 23:14:56 INFO - PROCESS | 20692 | __metrics Screen width/height:1600/1200 23:14:56 INFO - PROCESS | 20692 | colorDepth:24 23:14:56 INFO - PROCESS | 20692 | Browser inner width/height: 1024/697 23:14:56 INFO - PROCESS | 20692 | __metrics 23:14:56 INFO - PROCESS | 20692 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:14:57 INFO - TEST-INFO | 20692: exit 0 23:14:57 INFO - Browser initialized. 23:14:57 INFO - Running cycle 1/1 for kraken test... 23:14:57 INFO - TEST-INFO | started process 20815 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplXaEqt/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:15:09 INFO - PROCESS | 20815 | RSS: Main: 149741568 23:15:09 INFO - PROCESS | 20815 | 23:15:12 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38053/tests/kraken/driver.html?testName=audio-beat-detection) 23:15:12 INFO - PROCESS | 20815 | RSS: Main: 151134208 23:15:12 INFO - PROCESS | 20815 | 23:15:15 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38053/tests/kraken/driver.html?testName=audio-dft) 23:15:15 INFO - PROCESS | 20815 | RSS: Main: 151044096 23:15:15 INFO - PROCESS | 20815 | 23:15:18 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38053/tests/kraken/driver.html?testName=audio-fft) 23:15:19 INFO - PROCESS | 20815 | RSS: Main: 145285120 23:15:19 INFO - PROCESS | 20815 | 23:15:21 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38053/tests/kraken/driver.html?testName=audio-oscillator) 23:15:21 INFO - PROCESS | 20815 | RSS: Main: 145174528 23:15:21 INFO - PROCESS | 20815 | 23:15:24 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38053/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:15:24 INFO - PROCESS | 20815 | RSS: Main: 145993728 23:15:24 INFO - PROCESS | 20815 | 23:15:27 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38053/tests/kraken/driver.html?testName=imaging-darkroom) 23:15:28 INFO - PROCESS | 20815 | RSS: Main: 146276352 23:15:28 INFO - PROCESS | 20815 | 23:15:31 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38053/tests/kraken/driver.html?testName=imaging-desaturate) 23:15:32 INFO - PROCESS | 20815 | RSS: Main: 147607552 23:15:32 INFO - PROCESS | 20815 | 23:15:35 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38053/tests/kraken/driver.html?testName=json-parse-financial) 23:15:35 INFO - PROCESS | 20815 | RSS: Main: 148197376 23:15:35 INFO - PROCESS | 20815 | 23:15:37 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38053/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:15:37 INFO - PROCESS | 20815 | RSS: Main: 148213760 23:15:37 INFO - PROCESS | 20815 | 23:15:39 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:15:40 INFO - PROCESS | 20815 | RSS: Main: 148242432 23:15:40 INFO - PROCESS | 20815 | 23:15:42 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:15:43 INFO - PROCESS | 20815 | RSS: Main: 149536768 23:15:43 INFO - PROCESS | 20815 | 23:15:45 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:15:46 INFO - PROCESS | 20815 | RSS: Main: 148017152 23:15:46 INFO - PROCESS | 20815 | 23:15:48 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:15:49 INFO - PROCESS | 20815 | RSS: Main: 147681280 23:15:49 INFO - PROCESS | 20815 | 23:15:50 INFO - PROCESS | 20815 | Cycle 1(1): loaded http://localhost:38053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38053/tests/kraken/driver.html?testName=ai-astar) 23:15:51 INFO - PROCESS | 20815 | RSS: Main: 148221952 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | __start_tp_report 23:15:51 INFO - PROCESS | 20815 | _x_x_mozilla_page_load 23:15:51 INFO - PROCESS | 20815 | _x_x_mozilla_page_load_details 23:15:51 INFO - PROCESS | 20815 | |i|pagename|runs| 23:15:51 INFO - PROCESS | 20815 | |0;ai-astar;112;106;112;110;111;125;110;110;111;110 23:15:51 INFO - PROCESS | 20815 | |1;audio-beat-detection;154;126;154;157;130;156;155;127;160;128 23:15:51 INFO - PROCESS | 20815 | |2;audio-dft;162;164;163;163;163;161;161;164;172;163 23:15:51 INFO - PROCESS | 20815 | |3;audio-fft;77;74;72;71;73;72;137;72;72;71 23:15:51 INFO - PROCESS | 20815 | |4;audio-oscillator;94;94;143;93;93;93;132;94;94;142 23:15:51 INFO - PROCESS | 20815 | |5;imaging-gaussian-blur;110;111;111;109;110;110;110;110;109;110 23:15:51 INFO - PROCESS | 20815 | |6;imaging-darkroom;147;147;147;148;146;148;147;148;147;148 23:15:51 INFO - PROCESS | 20815 | |7;imaging-desaturate;95;96;97;96;98;97;97;96;96;97 23:15:51 INFO - PROCESS | 20815 | |8;json-parse-financial;59;62;57;64;58;61;58;60;61;57 23:15:51 INFO - PROCESS | 20815 | |9;json-stringify-tinderbox;69;69;68;69;68;68;68;68;67;69 23:15:51 INFO - PROCESS | 20815 | |10;stanford-crypto-aes;84;87;87;86;86;91;84;93;85;85 23:15:51 INFO - PROCESS | 20815 | |11;stanford-crypto-ccm;117;123;115;124;115;123;126;115;124;119 23:15:51 INFO - PROCESS | 20815 | |12;stanford-crypto-pbkdf2;157;151;151;160;158;141;149;145;148;138 23:15:51 INFO - PROCESS | 20815 | |13;stanford-crypto-sha256-iterative;66;71;66;69;66;68;68;66;70;70 23:15:51 INFO - PROCESS | 20815 | __end_tp_report 23:15:51 INFO - PROCESS | 20815 | __start_cc_report 23:15:51 INFO - PROCESS | 20815 | _x_x_mozilla_cycle_collect,727 23:15:51 INFO - PROCESS | 20815 | __end_cc_report 23:15:51 INFO - PROCESS | 20815 | __startTimestamp1450941351204__endTimestamp 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | ------- Summary: start ------- 23:15:51 INFO - PROCESS | 20815 | Number of tests: 14 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:4.97 (4.5%) stddev-sans-first:5.27 23:15:51 INFO - PROCESS | 20815 | Values: 112.0 106.0 112.0 110.0 111.0 125.0 110.0 110.0 111.0 110.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:154.50 stddev:14.72 (9.5%) stddev-sans-first:15.22 23:15:51 INFO - PROCESS | 20815 | Values: 154.0 126.0 154.0 157.0 130.0 156.0 155.0 127.0 160.0 128.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.13 (1.9%) stddev-sans-first:3.27 23:15:51 INFO - PROCESS | 20815 | Values: 162.0 164.0 163.0 163.0 163.0 161.0 161.0 164.0 172.0 163.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:20.42 (28.4%) stddev-sans-first:21.64 23:15:51 INFO - PROCESS | 20815 | Values: 77.0 74.0 72.0 71.0 73.0 72.0 137.0 72.0 72.0 71.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.50 stddev:22.13 (23.7%) stddev-sans-first:22.96 23:15:51 INFO - PROCESS | 20815 | Values: 94.0 94.0 143.0 93.0 93.0 93.0 132.0 94.0 94.0 142.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:15:51 INFO - PROCESS | 20815 | Values: 110.0 111.0 111.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:15:51 INFO - PROCESS | 20815 | Values: 147.0 147.0 147.0 148.0 146.0 148.0 147.0 148.0 147.0 148.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.71 23:15:51 INFO - PROCESS | 20815 | Values: 95.0 96.0 97.0 96.0 98.0 97.0 97.0 96.0 96.0 97.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.50 stddev:2.31 (3.8%) stddev-sans-first:2.44 23:15:51 INFO - PROCESS | 20815 | Values: 59.0 62.0 57.0 64.0 58.0 61.0 58.0 60.0 61.0 57.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 23:15:51 INFO - PROCESS | 20815 | Values: 69.0 69.0 68.0 69.0 68.0 68.0 68.0 68.0 67.0 69.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:2.97 (3.4%) stddev-sans-first:2.98 23:15:51 INFO - PROCESS | 20815 | Values: 84.0 87.0 87.0 86.0 86.0 91.0 84.0 93.0 85.0 85.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:123.00 stddev:4.36 (3.5%) stddev-sans-first:4.48 23:15:51 INFO - PROCESS | 20815 | Values: 117.0 123.0 115.0 124.0 115.0 123.0 126.0 115.0 124.0 119.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:7.22 (4.8%) stddev-sans-first:7.18 23:15:51 INFO - PROCESS | 20815 | Values: 157.0 151.0 151.0 160.0 158.0 141.0 149.0 145.0 148.0 138.0 23:15:51 INFO - PROCESS | 20815 | 23:15:51 INFO - PROCESS | 20815 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.94 (2.8%) stddev-sans-first:1.92 23:15:51 INFO - PROCESS | 20815 | Values: 66.0 71.0 66.0 69.0 66.0 68.0 68.0 66.0 70.0 70.0 23:15:51 INFO - PROCESS | 20815 | -------- Summary: end -------- 23:15:51 INFO - PROCESS | 20815 | 23:15:52 INFO - TEST-INFO | 20815: exit 0 23:15:52 INFO - TEST-OK | kraken | took 60020ms 23:15:52 INFO - TEST-START | v8_7 23:15:52 INFO - operating with platform_type : linux_ 23:15:52 INFO - Initialising browser for v8_7 test... 23:15:52 INFO - TEST-INFO | started process 21103 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM0gcCq/profile http://localhost:38053/getInfo.html) 23:15:56 INFO - PROCESS | 21103 | __metrics Screen width/height:1600/1200 23:15:56 INFO - PROCESS | 21103 | colorDepth:24 23:15:56 INFO - PROCESS | 21103 | Browser inner width/height: 1024/697 23:15:56 INFO - PROCESS | 21103 | __metrics 23:15:56 INFO - PROCESS | 21103 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:15:57 INFO - TEST-INFO | 21103: exit 0 23:15:57 INFO - Browser initialized. 23:15:57 INFO - Running cycle 1/1 for v8_7 test... 23:15:57 INFO - TEST-INFO | started process 21225 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpM0gcCq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:09 INFO - PROCESS | 21225 | RSS: Main: 149958656 23:16:09 INFO - PROCESS | 21225 | 23:16:30 INFO - PROCESS | 21225 | Cycle 1(1): loaded http://localhost:38053/tests/v8_7/run.html (next: http://localhost:38053/tests/v8_7/run.html) 23:16:31 INFO - PROCESS | 21225 | RSS: Main: 146612224 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | __start_tp_report 23:16:31 INFO - PROCESS | 21225 | _x_x_mozilla_page_load 23:16:31 INFO - PROCESS | 21225 | _x_x_mozilla_page_load_details 23:16:31 INFO - PROCESS | 21225 | |i|pagename|runs| 23:16:31 INFO - PROCESS | 21225 | |0;Richards;166.47244880972198 23:16:31 INFO - PROCESS | 21225 | |1;DeltaBlue;186.25442354255912 23:16:31 INFO - PROCESS | 21225 | |2;Encrypt;280.2690582959641 23:16:31 INFO - PROCESS | 21225 | |3;Decrypt;5208.333333333333 23:16:31 INFO - PROCESS | 21225 | |4;RayTrace;1050.420168067227 23:16:31 INFO - PROCESS | 21225 | |5;Earley;709.7232079488999 23:16:31 INFO - PROCESS | 21225 | |6;Boyer;12292.682926829268 23:16:31 INFO - PROCESS | 21225 | |7;RegExp;25300 23:16:31 INFO - PROCESS | 21225 | |8;Splay;592.7682276229995 23:16:31 INFO - PROCESS | 21225 | |9;NavierStokes;4830.917874396136 23:16:31 INFO - PROCESS | 21225 | __end_tp_report 23:16:31 INFO - PROCESS | 21225 | __startTimestamp1450941391167__endTimestamp 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | ------- Summary: start ------- 23:16:31 INFO - PROCESS | 21225 | Number of tests: 10 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 166.5 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#1] DeltaBlue Cycles:1 Average:186.25 Median:186.25 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 186.3 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 280.3 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 5208.3 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#4] RayTrace Cycles:1 Average:1050.42 Median:1050.42 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 1050.4 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#5] Earley Cycles:1 Average:709.72 Median:709.72 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 709.7 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 12292.7 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#7] RegExp Cycles:1 Average:25300.00 Median:25300.00 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 25300.0 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#8] Splay Cycles:1 Average:592.77 Median:592.77 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 592.8 23:16:31 INFO - PROCESS | 21225 | 23:16:31 INFO - PROCESS | 21225 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 23:16:31 INFO - PROCESS | 21225 | Values: 4830.9 23:16:31 INFO - PROCESS | 21225 | -------- Summary: end -------- 23:16:31 INFO - PROCESS | 21225 | 23:16:32 INFO - TEST-INFO | 21225: exit 0 23:16:32 INFO - TEST-OK | v8_7 | took 39910ms 23:16:32 INFO - SUITE-END | took 1211s 23:16:32 INFO - Completed test suite (00:20:11) 23:16:32 INFO - Working with test: dromaeo_css 23:16:32 INFO - Generating results file: dromaeo_css 23:16:32 INFO - Working with test: kraken 23:16:32 INFO - Generating results file: kraken 23:16:32 INFO - javascript benchmark 23:16:32 INFO - Working with test: v8_7 23:16:32 INFO - Generating results file: v8_7 23:16:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:16:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:16:32 INFO - process_Request line: dromaeo_css 6925.37 graph.html#tests=[[72,64,43]] 23:16:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:16:32 INFO - process_Request line: kraken 1512.80 graph.html#tests=[[232,64,43]] 23:16:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:16:32 INFO - process_Request line: v8_7 21462.83 graph.html#tests=[[230,64,43]] 23:16:32 INFO - RETURN: dromaeo_css: 6925.37 23:16:32 INFO - RETURN: kraken: 1512.80 23:16:32 INFO - RETURN: v8_7: 21462.83 23:16:32 INFO - javascript benchmark 23:16:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3163.0194639661704, 3183.411068952244, 3220.4686226772583, 3222.903312900613, 3239.6760323967605, 5269.578433725303, 5368.114261146911, 5422.05114105032, 5425.0, 5426.864328391787, 5350.170723537848, 5360.0, 5380.408155102936, 5398.595105367103, 5404.054290499166, 4652.302154676809, 4934.80260789568, 5091.541761241488, 5106.69359838409, 5136.794528218867, 4815.0610630926985, 5033.370828646419, 5049.545540901318, 5095.719735414551, 5114.897702045957, 4804.135255653999, 4878.902421951577, 4879.682820616648, 4897.0, 4916.7295798730875, 4941.0, 4949.109160351135, 4966.5778408835295, 4992.700437973734, 5001.099802035632, 4849.272609108627, 4891.755412229374, 4910.533499317559, 4941.678790878582, 4979.975100124512, 5064.721440320781, 5168.069747445458, 5220.712860792655, 5226.973865130688, 5236.214567814858, 5796.449337312949, 5811.302643682743, 5819.214406055213, 5839.386864379264, 5850.444207800252, 5730.885382292373, 5785.190073389729, 5801.7389217485315, 5840.8247752567495, 5866.120081987693, 5351.732413379315, 5399.946000540023, 5403.8108666196495, 5412.944475827216, 5413.702246376409, 5846.824595262149, 5905.734241959122, 5915.08316210988, 5920.674362910081, 5920.79277225295, 5700.543956483471, 5701.629394089371, 5703.287089113861, 5706.3722990471015, 5715.5427565794635, 5761.222234998306, 5785.71071446426, 5793.623414478046, 5806.2451881255165, 5806.622569532967, 5711.0, 5746.109353050284, 5750.511206547407, 5751.539876809845, 5774.0, 5695.7152142392715, 5736.6558006519745, 5765.538756899438, 5797.101449275369, 5816.040353341736, 4434.357018232403, 4449.621782148489, 4458.398116254329, 4469.396631454777, 4492.101579684077, 3906.1797022625565, 4037.7779222142476, 4043.1913617276664, 4043.4339192512484, 4094.2220978014084, 5398.595105367113, 5406.83779486616, 5408.648437851527, 5410.458954104637, 5410.540104091197, 5742.13867919807, 5797.24635797352, 5803.680797556175, 5821.825345239649, 5853.64878107315, 5464.672119672753, 5468.7265636718, 5472.042392581282, 5474.671519708831, 5480.123180291134, 4960.578350840146, 5038.5969122470115, 5048.570871475966, 5053.747312634354, 5091.9236211456855, 5915.112733089984, 5965.224520812267, 5968.22413086296, 5990.161377407167, 6042.788502402483, 5800.622959507618, 5822.534197264294, 5824.3593204748295, 5827.9417205829095, 5836.9416305838095, 5850.882982340415, 5906.143609176731, 5979.910301345571, 6009.549283803644, 6028.367021462684, 5685.0, 5702.942970570241, 5716.228309178207, 5718.857028574319, 5759.596828222152, 5794.82615521535, 5813.418658134322, 5843.415658434293, 5844.211031510692, 5866.120081987736, 5633.746481408429, 5712.11462223356, 5713.942860571341, 5723.341815691082, 5763.221965034834, 5607.158926161109, 5680.573956953162, 5754.510866576388, 5763.0, 5817.592768506164, 5530.889382212414, 5555.611107222456, 5563.05428077236, 5566.053770859045, 5606.551475881838, 5578.330600327987, 5595.608307418442, 5658.094704847204, 5678.176664383724, 5697.344805347272, 5508.807191748269, 5544.7782088716, 5560.249366335493, 5569.749361278671, 5637.887242255214], "unit": "score", "name": "dojo.html", "value": 5342.246848909882}, {"lowerIsBetter": false, "replicates": [559.6997463568038, 569.345252959097, 581.3866370978618, 615.2371059885741, 617.5183356981556, 35886.99999999997, 36588.45117323239, 36755.44866827, 37006.25987480249, 37070.44394334087, 41570.58429415705, 42140.789296053554, 42360.0, 42433.7878310608, 42578.0, 8824.691135810264, 8961.372703910729, 8993.100689930987, 9015.053419390968, 9019.413738107001, 8684.13158684133, 8724.0, 8786.736397908073, 8798.51608161554, 8800.251978581828, 8802.07578204289, 8815.911840881605, 8880.689175878813, 8882.822343553125, 8892.688755893545, 8790.6923257686, 8811.251043661296, 8856.601452934568, 8879.422837515542, 8893.911060889406, 8555.10171431997, 8665.870011949826, 8666.220040196413, 8666.566671666455, 8672.869906951337, 39626.20747585061, 40035.19929601392, 40173.59826401757, 40176.79911600423, 40294.0, 3241.222106694376, 3256.9185770355693, 3281.2453135778665, 3392.796432214075, 4012.2376748417705, 29471.26321841971, 29965.25086872824, 30463.23841903948, 30619.540706889413, 31170.844145779352, 3703.518542589473, 3725.0873535983587, 3785.1483416231404, 3806.448065030555, 3847.03824043989, 263310.0, 263313.0, 263499.6825015882, 263530.0, 263824.0, 54342.18486722702, 54990.87568432384, 59481.70259148676, 59861.0, 62320.68839655773, 57015.714921425126, 57250.141247881314, 57367.71316143392, 57503.71248143816, 57565.42434575601, 14667.413303467742, 14771.0, 14892.106473611619, 14923.626909327353, 14945.775813362809, 11982.58060967862, 12036.338001409831, 12083.697907552205, 12104.87895121055, 12108.455119519644, 20435.080421381073, 20749.89625051865, 20874.47813804637, 21067.789322106582, 21086.789132108788, 7545.396368290523, 7728.227177282227, 7809.3752499799875, 7835.921640783519, 7867.331276841418, 988.2983082011708, 1021.6117875207374, 1021.7241344836852, 1068.391017120234, 1073.4579037586125, 25691.229263122135, 27234.863825680746, 27241.86379068092, 27313.86343068272, 27406.314842129108, 1029.9897001030045, 1046.0742243114898, 1061.4533515239657, 1099.796537640523, 1141.6137589794018, 15125.773113403307, 15522.922385388001, 15667.843321566867, 15792.842071579136, 15964.281607327699, 336906.0, 337785.0, 338574.0, 340019.0, 340938.0, 45215.547844521134, 45504.317435238496, 45775.0, 45806.31290530645, 46018.30972535415, 1360.3946243921557, 1369.5343583181766, 1370.8492065872547, 1371.4788380415378, 1373.8694823991705, 25648.487030259665, 26640.33399164959, 26988.73011269862, 27015.459690806467, 27930.441391171655, 43632.0, 43872.56127438685, 44163.77918110389, 44187.77906110449, 44313.77843110764, 255719.0, 255999.0, 256698.0, 256799.0, 257158.0, 31171.37657246797, 32424.837875811412, 32534.0, 32829.045385915386, 32964.0, 38432.2313553733, 38986.6101338983, 39420.40869387019, 39601.405978910916, 40648.0, 33524.66475335313, 36529.63470365262, 36667.81666091653, 36926.89219323425, 37167.442488362154, 33602.0, 33753.493697594065, 33798.32403351968, 34075.31849362949, 36178.8191059043, 32806.34387312193, 32826.67173328236, 33288.50067248945, 33422.16444588808, 33467.33065338728, 29942.25144371408, 30330.69669303367, 30456.695433045385, 31045.68954310428, 31551.84224078865, 24553.75446245515, 24643.0, 24999.87500062488, 25201.873990630662, 25269.87365063163], "unit": "score", "name": "ext.html", "value": 18211.70279787289}, {"lowerIsBetter": false, "replicates": [343.9037069620507, 344.411057092372, 346.2227299712145, 346.6464206509361, 348.0723870884094, 16173.353065877365, 16710.24803883825, 17821.465356039305, 17931.193096310664, 18450.354237601685, 11486.770264594703, 12981.675458113528, 16070.517884463485, 16076.196190190472, 16102.436414725487, 4644.3962284903, 5605.495505404513, 5636.859078523049, 5640.605157638967, 5643.943560564403, 5448.700321482317, 5578.804741834037, 5626.465485778845, 5627.634203776762, 5638.238837756891, 4489.663275254369, 5111.565516931066, 5243.68537887728, 5553.333599968009, 5561.833145005657, 5294.735263236861, 5310.15037593985, 5331.120365139747, 5354.785808567672, 5356.464353564651, 5194.844154675366, 5428.972855135738, 5458.426865179139, 5462.562994960434, 5474.616776825624, 13032.0, 13186.86813131866, 13280.07039507235, 13522.12106213103, 13558.525451609245, 2127.2022991378235, 2130.637791575436, 2147.5382792699643, 2154.3859999899955, 2205.8125059369972, 9186.586603602787, 9540.045995400475, 9617.90382096177, 9735.951320243425, 10185.236107291983, 1773.866959978007, 1828.9176987035614, 1864.7016477363693, 1873.8313551780268, 1935.3516571948273, 54427.45572544263, 58138.127928081114, 63567.04649430262, 64297.35702642961, 64926.0, 10442.2168337375, 10496.317739346918, 10529.05238528536, 10583.62957296491, 10608.787824243473, 13577.11748736329, 13580.185188888698, 13594.796078058836, 13604.795928061087, 13644.386002629906, 7371.705131794668, 7484.775456736306, 7515.421761430051, 7537.2085930977555, 7538.736144234926, 7126.6080365579355, 7181.3177748114895, 7189.388901943289, 7206.423486121098, 7228.31331023552, 4491.595756381941, 4582.152301824173, 4588.990422107197, 4598.2412901871485, 4599.126166028444, 1850.731643911652, 1881.200489791833, 1881.9341323053627, 1887.877287976277, 1932.9226830926605, 425.84669518973146, 425.9850905218305, 428.4858170195715, 438.7806096951524, 446.6359916667905, 10937.617183398543, 11456.312621242752, 11577.421128943519, 11579.826302605468, 11705.063594912386, 923.9445633262026, 932.9533523323806, 968.8740463739668, 975.6975337645353, 1025.43601019439, 9055.320850936207, 9243.075692430837, 9256.166944974984, 9286.535673216447, 9328.253739700807, 514289.0, 520777.0, 522709.0, 542733.0, 545726.0, 45758.771206144425, 76468.0, 78675.0, 84276.57861710775, 84553.35762883886, 1158.073541167063, 1179.292424545266, 1180.0972256223995, 1197.5389475051993, 1204.5723768062387, 16352.345906164097, 16439.0, 16444.424445144363, 16456.917715411826, 16558.254878530253, 35248.11879702925, 35480.64519354773, 35775.60131787476, 36016.459753104245, 37312.81343593264, 48564.75717621389, 52106.739466302424, 53151.734241328544, 53256.0, 54882.0, 8846.203841654282, 9666.806663866824, 9895.158911492605, 9927.652532161339, 10026.949865250626, 10945.179111566824, 10960.945195273973, 11056.889431105908, 11135.72160695989, 11140.888591113986, 13062.477500900237, 14046.578602641937, 14512.85487145115, 14874.553763387115, 15007.024543404645, 13854.584362469142, 14057.929710351384, 14394.0, 14401.63995900111, 14744.852551474349, 14489.927550362603, 14598.854011459749, 14769.335379908145, 14770.409183632535, 14866.405343786128, 9751.609935602497, 9822.803543928938, 9855.35940163887, 9869.25980551476, 9899.703008909744, 10758.838617420588, 12233.0, 14323.14061156334, 14609.342579584158, 15244.618884527976], "unit": "score", "name": "jquery.html", "value": 8442.09801065234}, {"lowerIsBetter": false, "replicates": [1452.2448326870026, 1498.1535432480648, 1606.3092870065882, 1629.6170399956015, 1765.5497848048753, 6594.538382313234, 6799.796006119812, 6982.476314276424, 7070.717171313147, 7103.147622285326, 7043.894341584867, 7071.0807595012575, 7108.289171082889, 7127.928720712791, 7143.107111611049, 2210.160139147126, 2229.698990636268, 2243.2372993182316, 2252.966205506919, 2255.0528777913314, 2167.2739632223224, 2184.2246002669062, 2247.550489902018, 2248.0895237428867, 2249.4263962689492, 2194.8353873459555, 2216.6785816056663, 2229.8996545155505, 2242.988785056081, 2255.289583781104, 2237.8545394549383, 2258.3902346366554, 2271.250487339174, 2272.545490901818, 2273.1702928431087, 2214.5903007943584, 2254.402583315423, 2259.1302348595746, 2260.1298500077587, 2261.8190544756544, 6930.93069069313, 6958.8956165657555, 7001.719931202746, 7012.439004879649, 7019.859602807966, 4414.911701765946, 4473.932891006638, 4479.70881892676, 4491.820327186909, 4503.392042074311, 2948.1303015610447, 2984.8358340291275, 3000.3699223162944, 3003.6245469316336, 3016.3364059906785, 992.3896803465889, 1008.2992320337369, 1009.9040591143829, 1026.938383696973, 1059.5814653211937, 8965.0, 9059.0, 9065.229455496357, 9075.273978081737, 9091.13634204756, 3891.747036442622, 3924.430957511202, 3953.0512676957896, 3959.7228194026143, 3999.0802115513593, 7511.286427789351, 7565.546067235983, 7610.315071643578, 7652.349550288288, 7653.119891212582, 4354.521002689701, 4360.542143074995, 4388.29787234041, 4395.648348132142, 4401.559844015573, 4020.597940205956, 4042.5957404259925, 4050.5949405059846, 4058.7564746115327, 4078.388241763759, 3286.1291757684235, 3287.5561799157285, 3303.4714445688574, 3333.5666363372607, 3334.549835772188, 1028.8456731490187, 1029.7940411917496, 1037.7924415117006, 1043.4782608695652, 1046.576136664652, 1039.3763741754888, 1042.3120740311358, 1102.9962733912103, 1190.898773604236, 1292.4119525615822, 6692.631905245161, 6717.328267173243, 6771.966140169267, 6782.660866956632, 6796.626185559841, 1088.4992903264429, 1109.362116782853, 1114.6823155400673, 1124.9775004500027, 1129.1474936423112, 5338.306020217425, 5340.49265319794, 5361.973190134102, 5363.919541206885, 5377.7311134443125, 7924.920750792534, 8099.554524501091, 8150.75547733569, 8327.375446841512, 8367.0, 8063.193680632007, 8108.0, 8140.75577732669, 8164.0, 8208.917910820936, 6255.874882502416, 6516.0, 6570.835729106715, 6586.1438013058, 6596.142501474777, 6619.172603424572, 6644.667766611554, 6676.165479315086, 6676.732930682912, 6686.06395104676, 7312.744053958086, 7453.478256521991, 7476.626168691652, 7556.206598307099, 7560.697572097055, 7522.097348318237, 7576.962115189389, 7589.848203035798, 7598.544087354777, 7621.923780762121, 6345.746170153142, 6365.52258580599, 6380.904286435614, 6387.073874288295, 6421.1010458536775, 6671.26616072222, 6685.231198412245, 6802.251752307143, 6825.0, 6826.556273842184, 6282.246130464374, 6361.809145725636, 6403.0, 6540.967295163494, 6588.209414870246, 5671.489565939085, 6131.877362452815, 6225.533085018551, 6230.6884655767935, 6373.7131829066875, 6127.356627554221, 6129.509639228761, 6136.754529818936, 6153.169322141453, 6167.6916154193, 5815.709214539172, 5817.127430885232, 5829.417058294137, 5837.066069428871, 5869.6771677558145, 5799.130130480462, 5972.0, 5982.850428739316, 5995.6702381367695, 6019.398060193946], "unit": "score", "name": "mootools.html", "value": 4156.21222182684}, {"lowerIsBetter": false, "replicates": [331.4183607768366, 335.27413150529105, 343.7593684420906, 346.2434580441735, 349.37461943121815, 6251.656158911258, 6303.464205542528, 6386.64873431961, 6389.1055252264605, 6423.678816059196, 6101.389861013897, 6267.843303917404, 6269.0, 6273.466755325791, 6280.591761535497, 4816.44610869751, 4831.347768051303, 4834.685745426554, 4835.709857408549, 4841.370621819158, 4831.541003604652, 4836.298736683197, 4841.443234028096, 4842.636802239828, 4850.781714822824, 4726.432828060638, 4806.4472585652575, 4809.374781278429, 4822.6624136310475, 4824.734639594821, 4797.544233297866, 4798.184308667517, 4800.063987522434, 4809.903801923977, 4810.326554282403, 4194.28697121487, 4214.515330736974, 4215.557366476537, 4221.366794980747, 4224.302990006645, 5932.169496270526, 5974.4921681657115, 5975.641461512279, 5980.730867110947, 5999.850003749898, 5462.6995515246645, 5638.774449022034, 5641.915371269434, 5644.4073372295725, 5655.830325090254, 6718.05947167397, 6724.731010759564, 6730.226024007204, 6734.461243100589, 6734.8989765153565, 4666.626669866437, 4668.276417155346, 4672.859814205579, 4674.532546745332, 4678.672492925497, 6896.0, 7051.153861536597, 7057.153141622986, 7098.396636285922, 7112.786616401516, 4703.576678098988, 4731.952680473151, 4734.621230301636, 4735.502772208937, 4735.83424580138, 4799.760011999386, 4800.567948884547, 4801.231802911588, 4807.591354734886, 4812.639052071108, 5575.303087114111, 5580.135079062752, 5583.106702927512, 5595.0, 5605.019121653694, 6540.934590654033, 6797.626130562768, 6815.829604259933, 6816.829579260459, 6835.555688880307, 1655.329591515438, 1681.638447733743, 1686.53620254431, 1690.2562872336132, 1692.9830701693072, 1099.1371773158032, 1113.4098927568402, 1117.1286396610656, 1119.1326721790676, 1124.2916962313855, 6330.987042073246, 6341.873162536724, 6348.079528468438, 6357.872842543124, 6369.20384951881, 6889.965550172317, 6919.481038922101, 6925.203601585781, 6928.722851086001, 6934.271901450275, 6225.533085018551, 6286.4342209201395, 6328.17733694626, 6328.905066424008, 6342.778002769973, 3756.981215093907, 3813.2182902505474, 3836.8848934532007, 3838.846446142123, 3845.5962123977138, 7406.07424071991, 7434.070741157356, 7436.739714110088, 7437.702491900263, 7447.776566703008, 7019.192792828788, 7231.674574644154, 7235.131784185826, 7256.346928776436, 7262.963685181646, 7356.595387253646, 7391.33477986973, 7391.85216295671, 7393.667284972189, 7403.444741644398, 6968.407685346802, 7007.299270073156, 7011.929880701332, 7011.964940175267, 7028.367446929801, 6797.89803152963, 6939.340762627542, 6955.826104347432, 6958.269381714847, 6965.825854353681, 7349.118105827335, 7355.632218389166, 7371.889421658572, 7389.630518474162, 7402.444816638881, 4706.0, 4752.9287060694805, 4758.785854636619, 4765.8570242892765, 4783.115123702126, 6853.554518956252, 6876.553024053421, 7049.859002819812, 7057.788266352018, 7079.0, 6854.588724676535, 6877.793666190022, 6881.243063263138, 6887.345702158287, 6898.965505172442, 6744.69648865812, 6818.318168183142, 6820.863582728219, 6836.38472537474, 6841.521093523605, 6604.7027883746305, 6713.832154196184, 6723.966380168068, 6731.124953755981, 6742.157230346207, 6830.077939478306, 6877.759278425231, 6888.655567221719, 6895.862082758216, 6903.792886213421, 6660.467162626881, 6689.899651505134, 6695.263521012587, 6699.263081060982, 6735.191776986793], "unit": "score", "name": "prototype.html", "value": 5083.348057696092}, {"lowerIsBetter": false, "replicates": [714.1893950366334, 718.5832217313958, 756.6141267953342, 774.4462709162948, 803.5982008995502, 12659.936700316497, 12831.0, 12966.870331296685, 12980.221186728779, 12986.350682465874, 11388.430578471063, 12054.276743395403, 12234.510619575229, 12247.632571022861, 12335.19821211623, 789.6801795272924, 793.5754371411296, 802.8033131882697, 809.4778867630375, 822.7326119011316, 786.0096278688865, 799.1050023973129, 801.5311043039828, 805.1505661527086, 826.1408135539062, 831.9584020798966, 835.2524490580927, 838.4801423117646, 839.1398816213369, 867.4795122926257, 829.1045670675655, 829.324100857802, 835.8913341265596, 840.3277378097528, 872.2978002707817, 605.5972778102556, 605.9636421814705, 609.5793902207507, 616.2851092732409, 638.0047126482656, 12169.93915030428, 12320.459942507186, 12364.381780910919, 12400.00799936003, 12422.875771242263, 11026.44867756609, 11028.22802403832, 11200.0, 11263.774724505545, 11567.942160289229, 9853.0, 9976.251781116373, 9976.600935962553, 10169.949150254275, 10273.743156421075, 3558.857645694169, 3594.6405359464106, 3631.963680363189, 3632.5640923089136, 3646.74472786905, 45208.99999999967, 45212.77393613011, 48333.0, 48404.27393589099, 48424.51575484271, 9288.071192880658, 9354.551902578309, 9596.0, 9688.224942004623, 10006.349587276804, 17703.73444398335, 17749.66877484194, 17913.641727165385, 17921.641567168583, 17971.101444927703, 7592.202818703957, 7727.227277272228, 7736.6518506667335, 7769.6115194240065, 7945.64244608994, 4384.890377740582, 4403.471583410012, 4450.577195166454, 4453.821847126079, 4520.095980803852, 3106.3631955449077, 3107.254258977874, 3110.12916383413, 3128.8592013359453, 3137.074563003919, 544.3196004993757, 561.6630021986775, 568.5792513539951, 569.6724383479516, 573.8938296415176, 648.3322178156507, 673.8039979037248, 688.3220028272148, 712.5617745086838, 752.0862152484757, 8343.123971982975, 8787.736367908972, 8847.867281990775, 8992.0, 9056.0, 577.644748479682, 655.3512023097195, 679.1171477079777, 684.1516519515765, 687.6767919078026, 4053.8043125365107, 4260.488741351058, 4312.504062032844, 4328.156009578165, 4356.891077723082, 65432.34567654358, 65638.0, 65985.0, 66424.66787666031, 66617.66691166513, 49361.753191233816, 49524.009519810126, 53394.73302633462, 54576.72711636416, 55104.448955510736, 47343.5265647346, 49398.753006234736, 49604.75197623989, 50446.49553504418, 50730.49269507331, 8178.386621003568, 8514.659413623385, 8764.693235736719, 8794.91205087941, 8884.73345799627, 36267.0, 36304.63695363013, 36746.63253367432, 36925.63074369329, 37285.0, 45488.0, 48665.0, 48756.756216218695, 48943.75528122479, 49067.263991040876, 10822.188335874998, 11374.374409407232, 11382.715432113931, 11450.225215091674, 11617.477213525242, 12251.326177059991, 12494.625161245178, 12821.743565128832, 12973.286469243905, 13016.15394999322, 10983.725406864893, 11071.501782419971, 11156.609518666808, 11763.117766167401, 11995.64013079609, 11333.489992950503, 11643.359615220905, 11690.76618467609, 11958.282503049844, 12346.444410001392, 11367.715807104889, 11502.367369794407, 11591.536338546364, 11670.241434306743, 11827.290362577929, 9911.752206194902, 10267.435291059064, 10409.68770936873, 10604.522796474332, 10648.094911932572, 9454.385464944757, 9554.61781528759, 9601.471919044241, 9916.157126644315, 10072.345297555636], "unit": "score", "name": "yui.html", "value": 6356.895806455349}], "name": "dromaeo_css", "value": 6925.365269241604}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 110.0, 111.0, 125.0, 110.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [154.0, 126.0, 154.0, 157.0, 130.0, 156.0, 155.0, 127.0, 160.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 163.0, 163.0, 161.0, 161.0, 164.0, 172.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 72.0, 71.0, 73.0, 72.0, 137.0, 72.0, 72.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 143.0, 93.0, 93.0, 93.0, 132.0, 94.0, 94.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 98.0, 97.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 62.0, 57.0, 64.0, 58.0, 61.0, 58.0, 60.0, 61.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.7}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 87.0, 86.0, 86.0, 91.0, 84.0, 93.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 115.0, 124.0, 115.0, 123.0, 126.0, 115.0, 124.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [157.0, 151.0, 151.0, 160.0, 158.0, 141.0, 149.0, 145.0, 148.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 66.0, 69.0, 66.0, 68.0, 68.0, 66.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1512.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [186.25442354255912], "unit": "score", "name": "DeltaBlue", "value": 354.98754199999996}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1050.420168067227], "unit": "score", "name": "RayTrace", "value": 704.469528}, {"lowerIsBetter": false, "replicates": [709.7232079488999], "unit": "score", "name": "Earley", "value": 939.0463669999997}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [25300.0], "unit": "score", "name": "RegExp", "value": 36.007312252964404}, {"lowerIsBetter": false, "replicates": [592.7682276229995], "unit": "score", "name": "Splay", "value": 137.47531699999993}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21462.8311840487}]} 23:16:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21462.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1512.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6925.37"}}} 23:16:32 INFO - Return code: 0 23:16:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:16:32 INFO - # TBPL SUCCESS # 23:16:32 INFO - Running post-action listener: _resource_record_post_action 23:16:32 INFO - Running post-run listener: _resource_record_post_run 23:16:33 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 566403072; Read time: 0; Write time: 560368 23:16:33 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 247828480; Read time: 0; Write time: 357084 23:16:33 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 318574592; Read time: 0; Write time: 203284 23:16:33 INFO - Running post-run listener: _upload_blobber_files 23:16:33 INFO - Blob upload gear active. 23:16:33 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:16:33 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 23:16:33 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'] 23:16:33 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 23:16:33 INFO - (blobuploader) - INFO - Open directory for files ... 23:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:16:34 INFO - (blobuploader) - INFO - Done attempting. 23:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:16:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:16:35 INFO - (blobuploader) - INFO - Done attempting. 23:16:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:16:35 INFO - Return code: 0 23:16:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:16:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:16:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588b31b369942bd9ba12195ee83335409746538c7372929cde3e2dcf8d8ab6bb05994eacfb43a7446f16101139978e8e5e1f484a65c62f3ab265ee8129136594", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11534274664b9efe8600a16438da54cab8cbd099ae7c8e238b764093d9b677ce520553065903bbfe9491e5cdc1fe46b9410a2d4e418a26e1ef1efcc1a237040c"} 23:16:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:16:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:16:35 INFO - Contents: 23:16:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/588b31b369942bd9ba12195ee83335409746538c7372929cde3e2dcf8d8ab6bb05994eacfb43a7446f16101139978e8e5e1f484a65c62f3ab265ee8129136594", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11534274664b9efe8600a16438da54cab8cbd099ae7c8e238b764093d9b677ce520553065903bbfe9491e5cdc1fe46b9410a2d4e418a26e1ef1efcc1a237040c"} 23:16:35 INFO - Copying logs to upload dir... 23:16:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1269.220291 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-23 23:16:35.436348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 23:16:35.439479) ========= 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-1450936830.767832-1519032560 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/588b31b369942bd9ba12195ee83335409746538c7372929cde3e2dcf8d8ab6bb05994eacfb43a7446f16101139978e8e5e1f484a65c62f3ab265ee8129136594", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11534274664b9efe8600a16438da54cab8cbd099ae7c8e238b764093d9b677ce520553065903bbfe9491e5cdc1fe46b9410a2d4e418a26e1ef1efcc1a237040c"} build_url:https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/HlB3di1GSRKOWyBV1S4XJw/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/588b31b369942bd9ba12195ee83335409746538c7372929cde3e2dcf8d8ab6bb05994eacfb43a7446f16101139978e8e5e1f484a65c62f3ab265ee8129136594", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11534274664b9efe8600a16438da54cab8cbd099ae7c8e238b764093d9b677ce520553065903bbfe9491e5cdc1fe46b9410a2d4e418a26e1ef1efcc1a237040c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-23 23:16:35.464295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 23:16:35.464617) ========= 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-1450936830.767832-1519032560 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004600 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-23 23:16:35.550183) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 23:16:35.550510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-23 23:16:35.550838) ========= ========= Total master_lag: 0.27 =========