builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1453488550.3 results: success (0) buildid: 20160122083030 builduid: 5871b987d8624c8c92284ae9f28e9151 revision: 1cf358aab01b00bd6e04c492c1a604548063ea19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.297735) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.298235) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.298557) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006368 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.321787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.322123) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.335491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.335826) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.385856) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.386197) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.386604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.386933) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 10:49:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.5M=0s 2016-01-22 10:49:10 (31.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092674 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.492612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.492995) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020602 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.542926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:10.543323) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1cf358aab01b00bd6e04c492c1a604548063ea19 --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 1cf358aab01b00bd6e04c492c1a604548063ea19 --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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 10:49:10,770 truncating revision to first 12 chars 2016-01-22 10:49:10,770 Setting DEBUG logging. 2016-01-22 10:49:10,770 attempt 1/10 2016-01-22 10:49:10,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1cf358aab01b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 10:49:11,303 unpacking tar archive at: fx-team-1cf358aab01b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825693 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:11.382382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:11.382807) ========= echo 1cf358aab01b00bd6e04c492c1a604548063ea19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1cf358aab01b00bd6e04c492c1a604548063ea19'] 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1cf358aab01b00bd6e04c492c1a604548063ea19 program finished with exit code 0 elapsedTime=0.004434 script_repo_revision: '1cf358aab01b00bd6e04c492c1a604548063ea19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:11.433812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:11.434162) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 10:49:11.444307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-22 10:49:11.444617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:49:11 INFO - MultiFileLogger online at 20160122 10:49:11 in /builds/slave/test-pgo 10:49:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:49:11 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:49:11 INFO - {'append_to_log': False, 10:49:11 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:49:11 INFO - 'blob_upload_branch': 'Fx-Team', 10:49:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:49:11 INFO - 'branch': 'Fx-Team', 10:49:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:11 INFO - 'config_files': ('talos/linux_config.py',), 10:49:11 INFO - 'default_actions': ('clobber', 10:49:11 INFO - 'read-buildbot-config', 10:49:11 INFO - 'download-and-extract', 10:49:11 INFO - 'populate-webroot', 10:49:11 INFO - 'create-virtualenv', 10:49:11 INFO - 'install', 10:49:11 INFO - 'run-tests'), 10:49:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:11 INFO - 'download_minidump_stackwalk': True, 10:49:11 INFO - 'download_symbols': 'ondemand', 10:49:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:11 INFO - 'installer_path': 'installer.exe', 10:49:11 INFO - 'log_level': 'info', 10:49:11 INFO - 'log_name': 'talos', 10:49:11 INFO - 'log_to_console': True, 10:49:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:49:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:49:11 INFO - 'opt_config_files': (), 10:49:11 INFO - 'pip_index': False, 10:49:11 INFO - 'sps_profile': False, 10:49:11 INFO - 'sps_profile_interval': 0, 10:49:11 INFO - 'suite': 'dromaeojs', 10:49:11 INFO - 'system_bits': '32', 10:49:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:11 INFO - 'title': 'talos-linux64-ix-008', 10:49:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:11 INFO - 'use_talos_json': True, 10:49:11 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:49:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:11 INFO - 'work_dir': 'build'} 10:49:11 INFO - ##### 10:49:11 INFO - ##### Running clobber step. 10:49:11 INFO - ##### 10:49:11 INFO - Running pre-action listener: _resource_record_pre_action 10:49:11 INFO - Running main action method: clobber 10:49:11 INFO - rmtree: /builds/slave/test-pgo/build 10:49:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:49:12 INFO - Running post-action listener: _resource_record_post_action 10:49:12 INFO - ##### 10:49:12 INFO - ##### Running read-buildbot-config step. 10:49:12 INFO - ##### 10:49:12 INFO - Running pre-action listener: _resource_record_pre_action 10:49:12 INFO - Running main action method: read_buildbot_config 10:49:12 INFO - Using buildbot properties: 10:49:12 INFO - { 10:49:12 INFO - "project": "", 10:49:12 INFO - "product": "firefox", 10:49:12 INFO - "script_repo_revision": "production", 10:49:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:49:12 INFO - "repository": "", 10:49:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:49:12 INFO - "buildid": "20160122083030", 10:49:12 INFO - "pgo_build": "True", 10:49:12 INFO - "basedir": "/builds/slave/test-pgo", 10:49:12 INFO - "buildnumber": 906, 10:49:12 INFO - "slavename": "talos-linux64-ix-008", 10:49:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:49:12 INFO - "platform": "ubuntu64_hw", 10:49:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:49:12 INFO - "branch": "fx-team", 10:49:12 INFO - "repo_path": "integration/fx-team", 10:49:12 INFO - "revision": "1cf358aab01b00bd6e04c492c1a604548063ea19", 10:49:12 INFO - "stage_platform": "linux64-pgo", 10:49:12 INFO - "builduid": "5871b987d8624c8c92284ae9f28e9151", 10:49:12 INFO - "slavebuilddir": "test" 10:49:12 INFO - } 10:49:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:49:12 INFO - Running post-action listener: _resource_record_post_action 10:49:12 INFO - ##### 10:49:12 INFO - ##### Running download-and-extract step. 10:49:12 INFO - ##### 10:49:12 INFO - Running pre-action listener: _resource_record_pre_action 10:49:12 INFO - Running main action method: download_and_extract 10:49:12 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:12 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json 10:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json 10:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:49:12 INFO - Downloaded 1448 bytes. 10:49:12 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:49:12 INFO - Using the following test package requirements: 10:49:12 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:12 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:49:12 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:49:12 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'jsshell-linux-x86_64.zip'], 10:49:12 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:49:12 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:12 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:49:12 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:49:12 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:49:12 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:49:12 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:49:12 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:49:12 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:12 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:13 INFO - Downloaded 22488230 bytes. 10:49:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:49:13 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:49:15 INFO - Return code: 0 10:49:15 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 10:49:15 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')]} 10:49:15 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:49:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:49:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:49:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:16 INFO - Downloaded 22488230 bytes. 10:49:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:49:16 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 10:49:17 INFO - Return code: 0 10:49:17 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')]} 10:49:17 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:49:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:49:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:18 INFO - Downloaded 10706572 bytes. 10:49:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 10:49:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 10:49:18 INFO - Return code: 0 10:49:18 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')]} 10:49:18 INFO - https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IrGgiU4cRCCLU69EOp4OAQ/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 10:49:20 INFO - Downloaded 55955407 bytes. 10:49:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:49:20 INFO - mkdir: /builds/slave/test-pgo/properties 10:49:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:49:20 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:49:20 INFO - Contents: 10:49:20 INFO - build_url:https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:49:20 INFO - Running post-action listener: _resource_record_post_action 10:49:20 INFO - Running post-action listener: set_extra_try_arguments 10:49:20 INFO - ##### 10:49:20 INFO - ##### Running populate-webroot step. 10:49:20 INFO - ##### 10:49:20 INFO - Running pre-action listener: _resource_record_pre_action 10:49:20 INFO - Running main action method: populate_webroot 10:49:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:49:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:49:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:49:20 INFO - '--tppagecycles', 10:49:20 INFO - '7'], 10:49:20 INFO - 'tests': ['tsvgm']}}, 10:49:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:49:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:49:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:49:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:49:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:49:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'tests': ['damp', 'tps']}, 10:49:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['damp', 'tps']}, 10:49:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:49:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:49:20 INFO - 'other': {'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'other_l64': {'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'other_nol64': {'tests': ['a11yr', 10:49:20 INFO - 'ts_paint', 10:49:20 INFO - 'tpaint', 10:49:20 INFO - 'sessionrestore', 10:49:20 INFO - 'sessionrestore_no_auto_restore']}, 10:49:20 INFO - 'svgr': {'tests': ['tsvgx', 10:49:20 INFO - 'tsvgr_opacity', 10:49:20 INFO - 'tart', 10:49:20 INFO - 'tscrollx', 10:49:20 INFO - 'cart']}, 10:49:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['tsvgx', 10:49:20 INFO - 'tsvgr_opacity', 10:49:20 INFO - 'tart', 10:49:20 INFO - 'tscrollx', 10:49:20 INFO - 'cart']}, 10:49:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'tests': ['tp5o']}, 10:49:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'talos_options': ['--e10s'], 10:49:20 INFO - 'tests': ['tp5o']}, 10:49:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'talos_options': ['--xperf_path', 10:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:20 INFO - 'tests': ['tp5n']}, 10:49:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:49:20 INFO - 'talos_options': ['--e10s', 10:49:20 INFO - '--xperf_path', 10:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:49:20 INFO - 'tests': ['tp5n']}}, 10:49:20 INFO - 'talos.zip': {'path': '', 10:49:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:49:20 INFO - Running post-action listener: _resource_record_post_action 10:49:20 INFO - ##### 10:49:20 INFO - ##### Running create-virtualenv step. 10:49:20 INFO - ##### 10:49:20 INFO - Running pre-action listener: _resource_record_pre_action 10:49:20 INFO - Running main action method: create_virtualenv 10:49:20 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:49:20 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 10:49:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:49:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:49:20 INFO - Using real prefix '/usr' 10:49:20 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:49:20 INFO - Installing distribute.............................................................................................................................................................................................done. 10:49:22 INFO - Installing pip.................done. 10:49:22 INFO - Return code: 0 10:49:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:49:22 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')]} 10:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:22 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')]} 10:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:22 INFO - Using env: {'DISPLAY': ':0', 10:49:22 INFO - 'HOME': '/home/cltbld', 10:49:22 INFO - 'LANG': 'en_US.UTF-8', 10:49:22 INFO - 'LANGUAGE': 'en_US:en', 10:49:22 INFO - 'LOGNAME': 'cltbld', 10:49:22 INFO - 'MAIL': '/var/mail/cltbld', 10:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:22 INFO - 'MOZ_NO_REMOTE': '1', 10:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:22 INFO - 'NO_EM_RESTART': '1', 10:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:22 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:22 INFO - 'SHELL': '/bin/bash', 10:49:22 INFO - 'SHLVL': '1', 10:49:22 INFO - 'TERM': 'linux', 10:49:22 INFO - 'TMOUT': '86400', 10:49:22 INFO - 'USER': 'cltbld', 10:49:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:22 INFO - '_': '/tools/buildbot/bin/python'} 10:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:22 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 10:49:22 INFO - Cleaning up... 10:49:22 INFO - Return code: 0 10:49:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:49:22 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')]} 10:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:22 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')]} 10:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:22 INFO - Using env: {'DISPLAY': ':0', 10:49:22 INFO - 'HOME': '/home/cltbld', 10:49:22 INFO - 'LANG': 'en_US.UTF-8', 10:49:22 INFO - 'LANGUAGE': 'en_US:en', 10:49:22 INFO - 'LOGNAME': 'cltbld', 10:49:22 INFO - 'MAIL': '/var/mail/cltbld', 10:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:22 INFO - 'MOZ_NO_REMOTE': '1', 10:49:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:22 INFO - 'NO_EM_RESTART': '1', 10:49:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:22 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:22 INFO - 'SHELL': '/bin/bash', 10:49:22 INFO - 'SHLVL': '1', 10:49:22 INFO - 'TERM': 'linux', 10:49:22 INFO - 'TMOUT': '86400', 10:49:22 INFO - 'USER': 'cltbld', 10:49:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:22 INFO - '_': '/tools/buildbot/bin/python'} 10:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:23 INFO - Downloading/unpacking psutil>=0.7.1 10:49:23 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 10:49:23 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 10:49:23 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 10:49:23 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 10:49:23 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 10:49:23 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 10:49:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:49:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:24 INFO - Installing collected packages: psutil 10:49:24 INFO - Running setup.py install for psutil 10:49:25 INFO - building 'psutil._psutil_linux' extension 10:49:25 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 10:49:25 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 10:49:25 INFO - building 'psutil._psutil_posix' extension 10:49:25 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 10:49:25 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 10:49:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:49:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:49:25 INFO - Successfully installed psutil 10:49:25 INFO - Cleaning up... 10:49:25 INFO - Return code: 0 10:49:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:25 INFO - Using env: {'DISPLAY': ':0', 10:49:25 INFO - 'HOME': '/home/cltbld', 10:49:25 INFO - 'LANG': 'en_US.UTF-8', 10:49:25 INFO - 'LANGUAGE': 'en_US:en', 10:49:25 INFO - 'LOGNAME': 'cltbld', 10:49:25 INFO - 'MAIL': '/var/mail/cltbld', 10:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:25 INFO - 'MOZ_NO_REMOTE': '1', 10:49:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:25 INFO - 'NO_EM_RESTART': '1', 10:49:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:25 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:25 INFO - 'SHELL': '/bin/bash', 10:49:25 INFO - 'SHLVL': '1', 10:49:25 INFO - 'TERM': 'linux', 10:49:25 INFO - 'TMOUT': '86400', 10:49:25 INFO - 'USER': 'cltbld', 10:49:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:25 INFO - '_': '/tools/buildbot/bin/python'} 10:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:49:25 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 10:49:25 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 10:49:25 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 10:49:25 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 10:49:25 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 10:49:25 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 10:49:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:49:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:49:27 INFO - Installing collected packages: mozsystemmonitor 10:49:27 INFO - Running setup.py install for mozsystemmonitor 10:49:27 INFO - Successfully installed mozsystemmonitor 10:49:27 INFO - Cleaning up... 10:49:27 INFO - Return code: 0 10:49:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:49: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')]} 10:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:27 INFO - Using env: {'DISPLAY': ':0', 10:49:27 INFO - 'HOME': '/home/cltbld', 10:49:27 INFO - 'LANG': 'en_US.UTF-8', 10:49:27 INFO - 'LANGUAGE': 'en_US:en', 10:49:27 INFO - 'LOGNAME': 'cltbld', 10:49:27 INFO - 'MAIL': '/var/mail/cltbld', 10:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:27 INFO - 'MOZ_NO_REMOTE': '1', 10:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:27 INFO - 'NO_EM_RESTART': '1', 10:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:27 INFO - 'SHELL': '/bin/bash', 10:49:27 INFO - 'SHLVL': '1', 10:49:27 INFO - 'TERM': 'linux', 10:49:27 INFO - 'TMOUT': '86400', 10:49:27 INFO - 'USER': 'cltbld', 10:49:27 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:27 INFO - '_': '/tools/buildbot/bin/python'} 10:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:27 INFO - Downloading/unpacking blobuploader==1.2.4 10:49:27 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 10:49:27 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 10:49:27 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 10:49:27 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 10:49:27 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 10:49:27 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 10:49:29 INFO - Downloading blobuploader-1.2.4.tar.gz 10:49:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:49:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:49:29 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 10:49:29 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 10:49:29 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 10:49:29 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 10:49:29 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 10:49:29 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 10:49:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:49:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:49:30 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 10:49:30 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 10:49:30 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 10:49:30 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 10:49:30 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 10:49:30 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 10:49:30 INFO - Downloading docopt-0.6.1.tar.gz 10:49:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:49:30 INFO - Installing collected packages: blobuploader, requests, docopt 10:49:30 INFO - Running setup.py install for blobuploader 10:49:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:49:30 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:49:30 INFO - Running setup.py install for requests 10:49:30 INFO - Running setup.py install for docopt 10:49:30 INFO - Successfully installed blobuploader requests docopt 10:49:30 INFO - Cleaning up... 10:49:30 INFO - Return code: 0 10:49:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49: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')]} 10:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49: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')]} 10:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 10:49:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 10:49:31 INFO - Using env: {'DISPLAY': ':0', 10:49:31 INFO - 'HOME': '/home/cltbld', 10:49:31 INFO - 'LANG': 'en_US.UTF-8', 10:49:31 INFO - 'LANGUAGE': 'en_US:en', 10:49:31 INFO - 'LOGNAME': 'cltbld', 10:49:31 INFO - 'MAIL': '/var/mail/cltbld', 10:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:31 INFO - 'MOZ_NO_REMOTE': '1', 10:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:31 INFO - 'NO_EM_RESTART': '1', 10:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:31 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:31 INFO - 'SHELL': '/bin/bash', 10:49:31 INFO - 'SHLVL': '1', 10:49:31 INFO - 'TERM': 'linux', 10:49:31 INFO - 'TMOUT': '86400', 10:49:31 INFO - 'USER': 'cltbld', 10:49:31 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:31 INFO - '_': '/tools/buildbot/bin/python'} 10:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:31 INFO - Running setup.py (path:/tmp/pip-finxFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:31 INFO - Running setup.py (path:/tmp/pip-Khq1_6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:31 INFO - Running setup.py (path:/tmp/pip-NgxMFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:31 INFO - Running setup.py (path:/tmp/pip-Y81aE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:31 INFO - Running setup.py (path:/tmp/pip-Np6QF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:31 INFO - Running setup.py (path:/tmp/pip-2w84kn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:31 INFO - Running setup.py (path:/tmp/pip-wpTQXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:31 INFO - Running setup.py (path:/tmp/pip-lEy1w5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:31 INFO - Running setup.py (path:/tmp/pip-rHg0Em-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:31 INFO - Running setup.py (path:/tmp/pip-8oesK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:31 INFO - Running setup.py (path:/tmp/pip-wkMlQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:31 INFO - Running setup.py (path:/tmp/pip-vbJbEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:32 INFO - Running setup.py (path:/tmp/pip-Qx2zCp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:32 INFO - Running setup.py (path:/tmp/pip-ntJRXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:32 INFO - Running setup.py (path:/tmp/pip-Fv2LFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:32 INFO - Running setup.py (path:/tmp/pip-Km4INi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:32 INFO - Running setup.py (path:/tmp/pip-YKWyoE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:49:32 INFO - Running setup.py install for manifestparser 10:49:32 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:49:32 INFO - Running setup.py install for mozcrash 10:49:32 INFO - Running setup.py install for mozdebug 10:49:32 INFO - Running setup.py install for mozdevice 10:49:32 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:49:32 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:49:32 INFO - Running setup.py install for mozfile 10:49:32 INFO - Running setup.py install for mozhttpd 10:49:33 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozinfo 10:49:33 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozInstall 10:49:33 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozleak 10:49:33 INFO - Running setup.py install for mozlog 10:49:33 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for moznetwork 10:49:33 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozprocess 10:49:33 INFO - Running setup.py install for mozprofile 10:49:33 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozrunner 10:49:33 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:49:33 INFO - Running setup.py install for mozscreenshot 10:49:33 INFO - Running setup.py install for moztest 10:49:34 INFO - Running setup.py install for mozversion 10:49:34 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:49:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:49:34 INFO - Cleaning up... 10:49:34 INFO - Return code: 0 10:49:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:34 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')]} 10:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:34 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')]} 10:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:34 INFO - Using env: {'DISPLAY': ':0', 10:49:34 INFO - 'HOME': '/home/cltbld', 10:49:34 INFO - 'LANG': 'en_US.UTF-8', 10:49:34 INFO - 'LANGUAGE': 'en_US:en', 10:49:34 INFO - 'LOGNAME': 'cltbld', 10:49:34 INFO - 'MAIL': '/var/mail/cltbld', 10:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:34 INFO - 'MOZ_NO_REMOTE': '1', 10:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:34 INFO - 'NO_EM_RESTART': '1', 10:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:34 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:34 INFO - 'SHELL': '/bin/bash', 10:49:34 INFO - 'SHLVL': '1', 10:49:34 INFO - 'TERM': 'linux', 10:49:34 INFO - 'TMOUT': '86400', 10:49:34 INFO - 'USER': 'cltbld', 10:49:34 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:34 INFO - '_': '/tools/buildbot/bin/python'} 10:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:34 INFO - Running setup.py (path:/tmp/pip-eOnsnE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:34 INFO - Running setup.py (path:/tmp/pip-nk92W3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:34 INFO - Running setup.py (path:/tmp/pip-tkBnqo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:34 INFO - Running setup.py (path:/tmp/pip-3yogyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:34 INFO - Running setup.py (path:/tmp/pip-L3ErkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:34 INFO - Running setup.py (path:/tmp/pip-GzYyrZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:34 INFO - Running setup.py (path:/tmp/pip-70yjzA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:34 INFO - Running setup.py (path:/tmp/pip-_w_AOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:49:34 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)) 10:49:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:34 INFO - Running setup.py (path:/tmp/pip-TW7338-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:35 INFO - Running setup.py (path:/tmp/pip-V62Lsn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:35 INFO - Running setup.py (path:/tmp/pip-mXksTz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:35 INFO - Running setup.py (path:/tmp/pip-MORgJj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:35 INFO - Running setup.py (path:/tmp/pip-1_6zpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:35 INFO - Running setup.py (path:/tmp/pip-LPysIK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:35 INFO - Running setup.py (path:/tmp/pip-ILaD0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:35 INFO - Running setup.py (path:/tmp/pip-yUX_B5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:49:35 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)) 10:49:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:35 INFO - Running setup.py (path:/tmp/pip-7PEm1E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:49:35 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)) 10:49:35 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)) 10:49:35 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)) 10:49:35 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)) 10:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:49:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:49:35 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 10:49:35 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 10:49:35 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 10:49:35 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 10:49:35 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 10:49:35 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 10:49:37 INFO - Downloading blessings-1.6.tar.gz 10:49:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:49:37 INFO - Installing collected packages: blessings 10:49:37 INFO - Running setup.py install for blessings 10:49:37 INFO - Successfully installed blessings 10:49:37 INFO - Cleaning up... 10:49:37 INFO - Return code: 0 10:49:37 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:49:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:37 INFO - Reading from file tmpfile_stdout 10:49:37 INFO - Current package versions: 10:49:37 INFO - argparse == 1.2.1 10:49:37 INFO - blessings == 1.6 10:49:37 INFO - blobuploader == 1.2.4 10:49:37 INFO - docopt == 0.6.1 10:49:37 INFO - manifestparser == 1.1 10:49:37 INFO - mozInstall == 1.12 10:49:37 INFO - mozcrash == 0.16 10:49:37 INFO - mozdebug == 0.1 10:49:37 INFO - mozdevice == 0.48 10:49:37 INFO - mozfile == 1.2 10:49:37 INFO - mozhttpd == 0.7 10:49:37 INFO - mozinfo == 0.9 10:49:37 INFO - mozleak == 0.1 10:49:37 INFO - mozlog == 3.1 10:49:37 INFO - moznetwork == 0.27 10:49:37 INFO - mozprocess == 0.22 10:49:37 INFO - mozprofile == 0.28 10:49:37 INFO - mozrunner == 6.11 10:49:37 INFO - mozscreenshot == 0.1 10:49:37 INFO - mozsystemmonitor == 0.0 10:49:37 INFO - moztest == 0.7 10:49:37 INFO - mozversion == 1.4 10:49:37 INFO - psutil == 3.1.1 10:49:37 INFO - requests == 1.2.3 10:49:37 INFO - wsgiref == 0.1.2 10:49:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:37 INFO - Using env: {'DISPLAY': ':0', 10:49:37 INFO - 'HOME': '/home/cltbld', 10:49:37 INFO - 'LANG': 'en_US.UTF-8', 10:49:37 INFO - 'LANGUAGE': 'en_US:en', 10:49:37 INFO - 'LOGNAME': 'cltbld', 10:49:37 INFO - 'MAIL': '/var/mail/cltbld', 10:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:37 INFO - 'MOZ_NO_REMOTE': '1', 10:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:37 INFO - 'NO_EM_RESTART': '1', 10:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:37 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:37 INFO - 'SHELL': '/bin/bash', 10:49:37 INFO - 'SHLVL': '1', 10:49:37 INFO - 'TERM': 'linux', 10:49:37 INFO - 'TMOUT': '86400', 10:49:37 INFO - 'USER': 'cltbld', 10:49:37 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:37 INFO - '_': '/tools/buildbot/bin/python'} 10:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 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)) 10:49:38 INFO - Cleaning up... 10:49:38 INFO - Return code: 0 10:49:38 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:38 INFO - Using env: {'DISPLAY': ':0', 10:49:38 INFO - 'HOME': '/home/cltbld', 10:49:38 INFO - 'LANG': 'en_US.UTF-8', 10:49:38 INFO - 'LANGUAGE': 'en_US:en', 10:49:38 INFO - 'LOGNAME': 'cltbld', 10:49:38 INFO - 'MAIL': '/var/mail/cltbld', 10:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:38 INFO - 'MOZ_NO_REMOTE': '1', 10:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:38 INFO - 'NO_EM_RESTART': '1', 10:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:38 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:38 INFO - 'SHELL': '/bin/bash', 10:49:38 INFO - 'SHLVL': '1', 10:49:38 INFO - 'TERM': 'linux', 10:49:38 INFO - 'TMOUT': '86400', 10:49:38 INFO - 'USER': 'cltbld', 10:49:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:38 INFO - '_': '/tools/buildbot/bin/python'} 10:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:38 INFO - Downloading/unpacking jsonschema 10:49:38 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 10:49:38 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 10:49:38 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 10:49:38 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 10:49:38 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 10:49:38 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 10:49:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:49:40 INFO - Downloading/unpacking functools32 (from jsonschema) 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 INFO - Downloading functools32-3.2.3-2.tar.gz 10:49:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:49:40 INFO - warning: no files found matching '*.txt' 10:49:40 INFO - no previously-included directories found matching 'build' 10:49:40 INFO - no previously-included directories found matching 'dist' 10:49:40 INFO - no previously-included directories found matching '.git*' 10:49:40 INFO - Installing collected packages: jsonschema, functools32 10:49:40 INFO - Running setup.py install for functools32 10:49:40 INFO - warning: no files found matching '*.txt' 10:49:40 INFO - no previously-included directories found matching 'build' 10:49:40 INFO - no previously-included directories found matching 'dist' 10:49:40 INFO - no previously-included directories found matching '.git*' 10:49:40 INFO - Successfully installed jsonschema functools32 10:49:40 INFO - Cleaning up... 10:49:40 INFO - Return code: 0 10:49:40 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:49:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4567bf2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ba850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, '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': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', '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 10:49:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 10:49:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 10:49:40 INFO - Using env: {'DISPLAY': ':0', 10:49:40 INFO - 'HOME': '/home/cltbld', 10:49:40 INFO - 'LANG': 'en_US.UTF-8', 10:49:40 INFO - 'LANGUAGE': 'en_US:en', 10:49:40 INFO - 'LOGNAME': 'cltbld', 10:49:40 INFO - 'MAIL': '/var/mail/cltbld', 10:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:40 INFO - 'MOZ_NO_REMOTE': '1', 10:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:40 INFO - 'NO_EM_RESTART': '1', 10:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 10:49:40 INFO - 'SHELL': '/bin/bash', 10:49:40 INFO - 'SHLVL': '1', 10:49:40 INFO - 'TERM': 'linux', 10:49:40 INFO - 'TMOUT': '86400', 10:49:40 INFO - 'USER': 'cltbld', 10:49:40 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:40 INFO - '_': '/tools/buildbot/bin/python'} 10:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:49:40 INFO - Downloading/unpacking flake8 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:40 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 10:49:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:49:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:49:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:42 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 10:49:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:49:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:49:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:49:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:49:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:49:43 INFO - no previously-included directories found matching 'docs/_build' 10:49:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:49:43 INFO - Running setup.py install for pep8 10:49:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:49:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:49:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:49:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:49:43 INFO - no previously-included directories found matching 'docs/_build' 10:49:43 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:49:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:49:43 INFO - Cleaning up... 10:49:43 INFO - Return code: 0 10:49:43 INFO - Running post-action listener: _resource_record_post_action 10:49:43 INFO - Running post-action listener: _start_resource_monitoring 10:49:43 INFO - Starting resource monitoring. 10:49:43 INFO - ##### 10:49:43 INFO - ##### Running install step. 10:49:43 INFO - ##### 10:49:43 INFO - Running pre-action listener: _resource_record_pre_action 10:49:43 INFO - Running main action method: install 10:49:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:49:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:49:43 INFO - Reading from file tmpfile_stdout 10:49:43 INFO - Detecting whether we're running mozinstall >=1.0... 10:49:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:49:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:49:43 INFO - Reading from file tmpfile_stdout 10:49:43 INFO - Output received: 10:49:43 INFO - Usage: mozinstall [options] installer 10:49:43 INFO - Options: 10:49:43 INFO - -h, --help show this help message and exit 10:49:43 INFO - -d DEST, --destination=DEST 10:49:43 INFO - Directory to install application into. [default: 10:49:43 INFO - "/builds/slave/test-pgo"] 10:49:43 INFO - --app=APP Application being installed. [default: firefox] 10:49:43 INFO - mkdir: /builds/slave/test-pgo/build/application 10:49:43 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'] 10:49:43 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 10:49:59 INFO - Reading from file tmpfile_stdout 10:49:59 INFO - Output received: 10:49:59 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:49:59 INFO - Running post-action listener: _resource_record_post_action 10:49:59 INFO - ##### 10:49:59 INFO - ##### Running run-tests step. 10:49:59 INFO - ##### 10:49:59 INFO - Running pre-action listener: _resource_record_pre_action 10:49:59 INFO - Running main action method: run_tests 10:49:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:49:59 INFO - Python 2.7.3 10:49:59 INFO - Return code: 0 10:49:59 INFO - grabbing minidump binary from tooltool 10:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:49:59 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 0x12b93f0>, '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 0x134b560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134ba10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:49:59 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 10:49:59 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 10:49:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:59 INFO - Return code: 0 10:49:59 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:49:59 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:49:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:49:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:49:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:49:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:50:00 INFO - Return code: 0 10:50:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:50:00 INFO - Using env: {'DISPLAY': ':0', 10:50:00 INFO - 'HOME': '/home/cltbld', 10:50:00 INFO - 'LANG': 'en_US.UTF-8', 10:50:00 INFO - 'LANGUAGE': 'en_US:en', 10:50:00 INFO - 'LOGNAME': 'cltbld', 10:50:00 INFO - 'MAIL': '/var/mail/cltbld', 10:50:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:50:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:00 INFO - 'MOZ_NO_REMOTE': '1', 10:50:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:50:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:00 INFO - 'NO_EM_RESTART': '1', 10:50:00 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:50:00 INFO - 'PWD': '/builds/slave/test-pgo', 10:50:00 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:50:00 INFO - 'SHELL': '/bin/bash', 10:50:00 INFO - 'SHLVL': '1', 10:50:00 INFO - 'TERM': 'linux', 10:50:00 INFO - 'TMOUT': '86400', 10:50:00 INFO - 'USER': 'cltbld', 10:50:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703', 10:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:00 INFO - '_': '/tools/buildbot/bin/python'} 10:50:00 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:50:01 INFO - mozversion application_buildid: 20160122083030 10:50:01 INFO - mozversion application_changeset: 1cf358aab01b00bd6e04c492c1a604548063ea19 10:50:01 INFO - mozversion application_display_name: Nightly 10:50:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:01 INFO - mozversion application_name: Firefox 10:50:01 INFO - mozversion application_remotingname: firefox 10:50:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:50:01 INFO - mozversion application_vendor: Mozilla 10:50:01 INFO - mozversion application_version: 46.0a1 10:50:01 INFO - mozversion platform_buildid: 20160122083030 10:50:01 INFO - mozversion platform_changeset: 1cf358aab01b00bd6e04c492c1a604548063ea19 10:50:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:50:01 INFO - mozversion platform_version: 46.0a1 10:50:01 INFO - using testdate: 1453488601 10:50:01 INFO - actual date: 1453488601 10:50:01 INFO - starting webserver on 'localhost:56136' 10:50:01 INFO - SUITE-START | Running 3 tests 10:50:01 INFO - TEST-START | dromaeo_css 10:50:01 INFO - operating with platform_type : linux_ 10:50:01 INFO - Initialising browser for dromaeo_css test... 10:50:01 INFO - TEST-INFO | started process 26613 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQp43TQ/profile http://localhost:56136/getInfo.html) 10:50:05 INFO - PROCESS | 26613 | __metrics Screen width/height:1600/1200 10:50:05 INFO - PROCESS | 26613 | colorDepth:24 10:50:05 INFO - PROCESS | 26613 | Browser inner width/height: 1024/697 10:50:05 INFO - PROCESS | 26613 | __metrics 10:50:05 INFO - PROCESS | 26613 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:50:05 INFO - PROCESS | 26613 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:06 INFO - TEST-INFO | 26613: exit 0 10:50:06 INFO - Browser initialized. 10:50:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:06 INFO - TEST-INFO | started process 26705 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQp43TQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:18 INFO - PROCESS | 26705 | RSS: Main: 148938752 10:50:18 INFO - PROCESS | 26705 | 10:51:08 INFO - PROCESS | 26705 | 1453488668821 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] 10:53:17 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56136/tests/dromaeo/cssquery-ext.html) 10:53:19 INFO - PROCESS | 26705 | RSS: Main: 271257600 10:53:19 INFO - PROCESS | 26705 | 10:56:21 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-ext.html (next: http://localhost:56136/tests/dromaeo/cssquery-jquery.html) 10:56:22 INFO - PROCESS | 26705 | RSS: Main: 231030784 10:56:22 INFO - PROCESS | 26705 | 10:59:24 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56136/tests/dromaeo/cssquery-mootools.html) 10:59:24 INFO - PROCESS | 26705 | RSS: Main: 227975168 10:59:24 INFO - PROCESS | 26705 | 11:02:26 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56136/tests/dromaeo/cssquery-prototype.html) 11:02:27 INFO - PROCESS | 26705 | RSS: Main: 209813504 11:02:27 INFO - PROCESS | 26705 | 11:05:29 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56136/tests/dromaeo/cssquery-yui.html) 11:05:30 INFO - PROCESS | 26705 | RSS: Main: 216567808 11:05:30 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | Cycle 1(1): loaded http://localhost:56136/tests/dromaeo/cssquery-yui.html (next: http://localhost:56136/tests/dromaeo/cssquery-dojo.html) 11:08:33 INFO - PROCESS | 26705 | RSS: Main: 239050752 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | __start_tp_report 11:08:33 INFO - PROCESS | 26705 | _x_x_mozilla_page_load 11:08:33 INFO - PROCESS | 26705 | _x_x_mozilla_page_load_details 11:08:33 INFO - PROCESS | 26705 | |i|pagename|runs| 11:08:33 INFO - PROCESS | 26705 | |0;dojo.html;3176.126565194572;3178.5073313636367;3218.115018369948;3221.3557288542283;3247.464168412212;5027.597792176626;5080.8983820323665;5190.403103643082;5210.780719213448;5273;5176.249443830642;5205.297284866542;5232.45059268777;5234.7120908350025;5271.973640131803;4725.362076119714;4766.690165139272;4797.328374027639;4813.374261346037;4854.927176092361;4832;4834.854954351375;4862.34358361622;4879.51204879511;4886.413630364361;4640.721556706591;4680.9297860532115;4716.952830471686;4768.761561921925;4805.471398146201;4767.261074533453;4773.474917759044;4778.020505796303;4780.330753694486;4815.22956326986;4750.738709370983;4759.095771803381;4760.857174284777;4769.093872164312;4770.689905156154;4910.1898186799135;4986.152354099811;5047.066292735855;5100.081985242655;5154.845354639367;5562.666240025571;5564.693941833198;5565;5571.832845014656;5579.442055794388;5598.832035038955;5603.271574695264;5606.439356064402;5613.410591887834;5615.831525054214;5084.288199652052;5158.3552055993005;5318;5376;5397.514223719805;5711.086226203871;5735.283089613798;5749.051406517961;5779.219805326311;5803.245578074823;5507.752151153208;5513;5513.558915286848;5526.613137080366;5527.889442211133;5345;5433.619646624698;5584.636998595079;5590.86022849432;5677.772889084473;5510.6969116698965;5518.172274158908;5521.5306698930235;5521.834344969658;5525.060739674265;5483.917741233885;5537.224788529609;5539.972300138554;5540.529055030287;5590;4266.2960611499375;4324.891877703082;4353.32523458858;4393.055493069006;4421.977890110529;3855.0747820523434;3877.2827027000094;3884.067823722343;3911.2568611963634;3920.843166273317;5128.435872054071;5136.178211486144;5155.175171972466;5162.328897243335;5169.4572069932865;5347.438518955531;5442.074847275972;5563.833085007456;5635.295588051494;5652.123920792284;5098.08234517783;5127.8718032048755;5130.743462826844;5132.5124113209185;5132.615053870974;4647.37260469839;4760.33355330254;4763.857084287477;4767.642426818003;4813.278008298713;5691.089425691952;5692.260006199251;5699.287589051369;5725.2843394575675;5753.798617048383;5619.887602247851;5624.971875140598;5628.465295796893;5645.802396916089;5647.717614119196;5593.07714227148;5670.5180059695385;5851.912221316768;5873.970630146822;5895.086261629454;5519.9448005521035;5535.0313695104005;5539.058360078877;5545;5589.273394458857;5573.080441727232;5595.8880822384135;5600.383957764561;5610.382857885547;5614.354349249888;5308.203769434615;5387.542058925035;5473.0969390050195;5477.945220547744;5493.917591236055;5374.355077390738;5392.865178370572;5400.810971616132;5400.9459905400445;5409.648372855751;5308.893822123613;5321.467853214647;5328.920066198933;5330.946690533045;5332;5275.366955965309;5315.3621565412395;5319.38827034896;5353.22378255143;5441.21102440136;5361.731913404236;5409.810656626999;5413.918791218056;5414.431484694208;5454.618176727591 11:08:33 INFO - PROCESS | 26705 | |1;ext.html;532.9626926115171;533.5331584863245;558.3662543013678;561.531121513536;576.723172877019;28349.574756378646;29048.854755726217;36264.45603315949;36764.26471470569;36831.81584092076;42236.57763422365;42794.35808462876;42973.35539966895;43061.569384306145;43149.78425107878;8487.78780530487;8696.47821130731;8698.043215246318;8699.478031318142;8699.652013919467;8495.065542790288;8629.784255393603;8631.223189912907;8632.13678632138;8634.26608738258;8614.18165274298;8620.784480387978;8705.390622656416;8712.477251364906;8718.520481373522;8572.742817715478;8638.352123590694;8653.826923461558;8661.653533858638;8668.826623467527;8460.915390846074;8608.053114157437;8613.095624959415;8621.224089831883;8629.482231066093;39577.40633890494;39985;40019;40084;40110.788367221605;3489;3505.8948231553095;3599.0642432967616;3816.255830113129;3887.9502534315575;26344.73655263442;26738.19785406441;26838.329041773915;26844.865775670998;27323.316917077034;3428.8971330860113;3433.6909678128836;3444.328355970587;3504.4918486819524;3580.9104772380897;253554;254798.99999999814;255061;255930;256203;53338;54161.72919135458;54351.18473222905;58535.707321463124;60230;55309.170362443794;55533;55564.44435555593;55580.444195557524;55647.44352556504;14990.550283491513;15080.924595376953;15083.698326033636;15165.24173791328;15184;10794.136469082454;11316.26444281119;11369.374684392273;11374.260673056391;11387.544498219979;17010.744838827428;19924.800751992294;20498;20529.48676283075;20559.8972005139;7651.770446886602;7799;7852.254035866584;7889.526628402315;7893.289603935674;940.7507010642186;967.6806653804227;1014.629660174046;1021.1575450253571;1035.5961175141701;26398.736012640013;26836.32909177247;27099.593506097423;27158.913643454434;27185;1033.3283365812283;1057.9735506612242;1067.2315932528568;1080.0657431322006;1150.4765331774022;14223.85776142246;14599;14695.632609184855;14789;14977.700445991019;315914;319070;319903;320323;321125;51451;51664.74167629138;51789.48210517922;51903.221451678255;51905.183318583666;1305.9869401306055;1318.2156616812981;1320.2210695689398;1321.8017297405274;1328.6545498170544;26247.60628590611;27596.448071038867;27784;27961.860190698917;28102.71897281001;46311;46710;46800.531994679615;46822.29766553573;46898.296525552825;284490;287487;288692;289206;289400;25580.488390232462;27791.583126252717;28576.42847143087;32352.83823580867;32636.184095397806;37448.251034979694;41260;42288.365674515524;42728.35907461453;43374.34938475989;31621.683783161872;32399.190020249684;32687.67312326846;33162.83418582891;33365.332693346485;32511.187220318734;32885.67114328826;34622;36283.45574816433;36531.26937461289;32764;34627.134321641155;35292.47061294031;35747.28505429929;35793;27114.864425677744;31260.218494537818;31532.684673153894;32524.349513009132;32854.178645534055;22679;23116.422089447897;23552.6467102997;23893.641595375735;23917.402064948514 11:08:33 INFO - PROCESS | 26705 | |2;jquery.html;351.7098393825094;355.3213362477667;365.67272291299287;367.2013370918252;372.8452692132765;13592.592222233348;13736.725265494684;15573.844261557395;16761.66476670466;17948.282068717235;15968.441104561314;16173.514794556182;16637.667246655088;16914.1542922854;16919.407820726276;5200.583953283738;5413.539849112811;5414.620976531624;5415.620906536544;5418.051840927842;3933.8819835404843;4055.797210139481;5253.868653283679;5328.5470734987375;5695.345035320929;5736.885262294752;5744.702119152331;5850.76596936122;5857.502112320458;5864.941350586503;5747.08046712524;5859.7949071782705;5869.442402971711;5880.5295576354;5880.55895807814;5042.294078828967;5194.740262986836;5197.818076367347;5217.139172036609;5224.869378265574;18757.780744251715;19697.606047879104;19761.30835420768;19958.900205498878;19987.900060499604;2200.8459407841456;2201.460642142685;2223.633100538409;2263.479399738053;2561.526117668219;12325.630231093082;12414;12567;12657.114002019862;13105.672358191026;1810.2849374497132;1812.8821626594229;1826.97259541107;1829.7712785901763;1876.2119909637984;50313.24530132051;50758.746206269105;54390.72804635991;56873.715631421575;57003.71498142524;9559.665411710557;9849.359791613522;10007.599696012223;10020.849687254697;10067.647632332833;12978.870211297955;13115.737685246433;13249.536266230636;13254.40355184019;13257.204567725967;7101.964490177619;7183.353498185188;7451.813704657318;7555.357794587521;7608.0489938757655;7295.489315747953;7331.951259526611;7349.081364829396;7356.558606483628;7385.409167266605;4290.849820256339;4397.802098905557;4444.511103778582;4450.242154349079;4482.574155455227;1671.8411750883647;1677.8070521889895;1716.9914150429167;1780.5250701524633;1793.5247159502742;913.5249670171606;946.8958414574391;968.5157421289356;973.2603221551531;977.745786095606;15431.61420964485;15478.767818482731;16054.919725401533;16258.349666013228;16981.150942452827;891.9152680495342;895.4716717136921;937.6624415210518;982.29274922056;990.4601991914424;9266.907330926739;9492.857607135898;9743.561539730728;9880.308378413441;9919.206463482904;423721;550188;557312;571858;579575;47744.28383574249;48952.75523622359;67588;72906.63546682338;73183.2681673187;1111.7832022755485;1143.422571601336;1159.6405114414558;1160.721426857548;1163.4531770068224;12283.69290767738;13876;15083.773743394077;15124.168170750714;15181;31719.889803856753;32655.18362040968;32826.34347313088;33373.16567085745;33523;36648;38060;38095.42856857094;38295.80852095833;38778.80610596929;7063.364297213276;7256.310650488195;7298.613263479921;7368.484206105735;7393.371563416955;9102.24996645193;10642.62750803749;10674.946625266824;10721.731956700833;10929.071028962628;8625.8706119407;8806.91193088061;9108.904951860977;9487.95256023743;9703.611855525982;9748.415095094317;9863.01369863008;10061.949690251502;10153.238507111848;10153.746156345855;9542.236621070437;9930;9957.820111687384;10106.797864042825;10107;6982.860342793218;7245.927540724525;7255.09311336083;7311.305425984523;7358;8850.867236991578;8985.910140898508;9154.496502692416;9468.905310946802;9598.808023839623 11:08:33 INFO - PROCESS | 26705 | |3;mootools.html;1372.997711670481;1473.4106357457015;1480.822301323841;1630.845069718377;1773.8226177382255;6484.902726459107;7654.923450765491;7787.532748035122;7794.610269486531;7802.687892484294;7548.245175482449;7708.5760283184545;7711.730089446871;7714.575698336589;7719.343855772266;1981.3065427100544;2031.7968203179637;2037.4600730806349;2285.5200407914317;2314.6875171851752;2307.826912981533;2389.64155376694;2389.916352927648;2393.3896856301617;2394.8443351182204;2253.86476811391;2281.53228588139;2282.2354511238673;2286.4398222435443;2292.713410823647;2289.587874182638;2309.711286089239;2312.6877871487304;2320.1183550250967;2330.8484948478294;2328.464453175779;2330.3358542815217;2336.217367181979;2346.636271377939;2361.4568649210605;7836.333911617519;7865.68537258509;7866.410019248522;7886.369090472748;7888.7633370998965;4799.496052914464;4878.268259761029;4891.070696567641;4911.631627627942;4912.38595175603;3067.1871953932227;3084.948509241352;3096.349766549005;3126.98436507816;3132.420502207099;978.4667356290838;992.7121134870879;996.038822536256;1018.9286749927508;1034.3173505486418;10562;10599.523021464052;10600.204984626107;10614.893851061468;10626.574937002511;4306;4379.58393952574;4396.384506169139;4410.867673969722;4442.111577684412;9209.95395023034;9226.86159707605;9251.629934802533;9278.396904201205;9281.257499400032;4775.594074503637;4776.593989510861;4784.760761961888;4786.593139583105;4788.880277993008;4264.061906380592;4264.978675106605;4297.333913243452;4303.74177549348;4335.024619460596;3416.7437442191936;3519.240379810095;3735.6264373562426;3777.6788972937607;3804.9429258561145;1239.8512178538454;1247.7255003899127;1260.836091308124;1271.0784681106124;1273.4651446392538;1183.0358258019687;1191.3447603817865;1196.8324434579165;1199.580146948561;1222.2177806204036;7160.355567998905;7249.855002900018;7320.96339518299;7328;7343.449241306924;1019.8317277649253;1023.8515415264745;1037.3205550364523;1046.942418167008;1051.6056478820442;5595.440455954372;5619.325680918316;5636.013697602985;5666.914996275059;5678.0915053591225;9112.681056163003;9250.121238482468;9329.626814927462;9664.661736839176;9678.419294842332;9558.761030974281;9679.854802177973;9683.273754468442;9692.806143877084;9699.817541053348;7230.2046774854725;7261.5280006799385;7434.814129646694;7524.021877156044;7526.360259378014;7056.82357941035;7079.8938015930835;7101.431885449048;7108.253633368422;7109.1824440187975;8305.626246819029;8419.915800842158;8427.915720842713;8616.698415555426;8621.09478504748;8555.401121921406;8852.822943541221;8889.4666320021;8891.866622000545;8905.51019693897;6814.1482314710665;6953.930460695531;6963.338482844122;6991.6853741580735;6993;6361.745530178741;6473.514486413444;6990.545614535039;7158.176809666955;7183.5330703504105;6659.700313485808;6856.142982127234;6918.688659010256;7015.614141222078;7079.221285658677;6835.58986460794;6876.965615171892;6900.068490753684;6963.6866341013765;7023.157221133497;6908.827279318058;6942.965285173542;6950.687219075053;6954.617496037767;6955.965220173866;6325.620462772248;6485.643289619116;6521.5108866834225;6522.21733391977;6527.249366322933;6569.770058047945;6586.769463068769;6611.867762644816;6615.6030638161865;6620.304867988792 11:08:33 INFO - PROCESS | 26705 | |4;prototype.html;339.7248228934563;348.8186143205533;351.73795522335854;355.8098161649285;357.9480975258586;5707.486326230638;5827.796027139051;5831;5837.941620583793;5845.912311315328;5627.6904770237625;5793.188953546507;5817.476427121558;5822.854428639275;5826.737796799154;4540.409746732928;4554.111948170108;4554.97722511387;4559.54404559543;4562.8631141065825;4363.170997510463;4416.183006143858;4469.3296005599095;4531.977340113295;4553.612942899857;4496.617787488068;4496.752678602676;4506.188886000535;4509.1658043262105;4515.051839113774;4504.166729155117;4508.188526065307;4514.774261286939;4517.796699148514;4521.683482156251;3992.5208974923194;3994.9201015979806;3996.540397854255;3996.620321069494;4006.9198616027807;5402.35171779385;5506.614536982413;5513.228148059275;5531.834044978657;5540.307461567304;5239.266502689627;5242.318498595197;5242.423333433319;5255.500727430888;5257.447967963385;5875.6474611523445;6246.0630905364105;6250.9998400255745;6256.874862502725;6257.687115644245;4180.937285940713;4277.807498662568;4382.035952090535;4392.385066090718;4394.318880573516;6362.745490180388;6457.515686323498;6458.354164583551;6462.644554549545;6462.806115816533;4473.642108631302;4474.79863406141;4476.798544065459;4478.7088839226;4482.238019536687;4468.106378724203;4538.500764915857;4541.046380260183;4546.636269098531;4559.156556037144;5199.74001299941;5209.192575150858;5215.6609820361555;5217.087009773274;5218.582513398919;6197.845053873689;6200.410960958701;6213.627182368982;6214.223222097238;6225.501959843202;1571.4578470427684;1592.8805339599576;1592.912389818548;1594.3224129744813;1596.5449846793608;1067.1836045425257;1075.3118004477142;1086.576235268246;1087.8096333141668;1110.6334909479851;5835.883282334329;5850.8537286567325;5852.268466441695;5853.795117170878;5856.238688970407;6376.043593461018;6389.5846769960735;6392.616443013434;6393.392627700361;6396.0725694774;5700.429957004267;5835.824925252249;5843.853903652358;5846.064629659234;5854.18041474194;3307.8015319080932;3419.452887537982;3424.845881935319;3425.3663072331697;3426.468897320919;6629.436497897733;6648;6652.900206496906;6659.067730517731;6659.334066593302;6498.285188629247;6504.382083702136;6507.772227971998;6512.706928188243;6518.9569668852755;6543.411093001652;6637.369449902251;6741.22475915276;6745.460363170934;6750.797476075725;6150.907736383869;6327.905081423874;6434.356564343529;6502.414782669583;6504.38208370204;6216.937830621636;6368.172137622079;6370.936290637034;6376.458001069961;6390.265119511316;6708.228553716385;6718.563293385914;6718.596884186964;6719.428848547733;6725.361090696376;4352.477702675699;4474.709143905636;4509.098180363875;4539.455265368177;4542.568455996675;6385.233771947396;6393.456556192589;6398.93601064002;6400.071989561395;6405.8718825624155;6222.968885155546;6233.688315584293;6234.345393733593;6235.46998505114;6236.064590311489;6047.9395206047375;6212.254529456494;6225.221847269091;6226.128342032029;6230.127782110599;6078.939210607838;6101.420365065312;6107.083937409247;6167.814965551041;6178.042403427476;6274.121622972879;6286.465650419583;6288.27684816252;6293.905591416224;6295.716692748746;5937.554683398676;6144.109104179958;6146.262448506208;6153.969230153821;6156.815295541141 11:08:33 INFO - PROCESS | 26705 | |5;yui.html;768.0322793280465;791.0586402181403;800.7117437722419;821.7509385733684;853.965841366345;13444.7311053779;13587.252701101435;13605.72788544231;13633.318334083306;13650;12718.93640531796;12778.55275065373;12788.104832661717;12792.104552681316;12837.037222208348;658.6509150150428;661.2527843536797;776.8912352270687;791.79809148667;793.2701914238885;794.1700922535964;794.1819925476768;801.2268161224417;802.7952872017627;803.2048272210528;830.3523251863556;831.3017065664841;831.4387788242942;833.2251006563893;838.4298676899706;680.3876511139989;681.492288245258;829.2453866981078;831.5883637599396;839.0560619303284;605.857623458487;614.9108379285024;618.9938100618981;621.2638023941598;622.6637615687523;12812.61562153137;12909.096363254575;12930.54743083997;12943.22340659554;13022.544210952572;12953.352332383438;13099.47602095915;13139;13266.602001939957;13391.933040334736;9859.211263098934;10006.299559030871;10028.197744180448;10158.796824063478;10270.229732770073;3510.4032314506594;3545.3263879862743;3548.432250839879;3580.158662714286;3693.1505753676806;46016.53983460156;46259.53740462586;46282.53717462816;46371.30443043357;46393.76803115997;10053.547590358452;10301.484925753683;10371.740706482247;10456.52945617449;10558.894411055944;18434.26262949467;18434.723479147822;18446.538836528925;18498.16758245882;18548.072596370126;6789.355011273921;7058.153021637437;7089;7136.107986501687;7160.749373771893;4051.8379264829077;4076.8369265229057;4082.9795851020554;4105.261053010427;4129.587041295907;2855.5002874497295;2861.084452975028;2863.5418333067028;2870.3111253299476;2883.423315336941;515.9974200128976;531.8085489223877;539.0055347883149;540.8404520666413;543.1716632136024;552.2516989479278;615.2002396884033;646.4505170605042;646.5086534233922;650.2099948562519;8105.594720263964;8248.711295104642;8266.462679925786;8337.749867503984;8445.324374050062;466.5987250964168;496.39439883342266;497.01094821305344;502.24913753938097;502.3921055522785;3716.7769933804057;3814.1990182062077;3830.9233815324096;3867.3812190049457;4068.06434520062;56364;60371;62776.37223627705;63355.366446335865;63379;46556.301655475196;46983.53016469791;48352.27471587929;50992;51288.487115129115;44501.55498445039;44903.326450103275;45616.31575526436;46931.29603055957;47061;8769.868451973098;8908.910910891067;9148.862767058632;9171.886217908937;9226.677066302647;31724.841375792974;32337;32797.67202327946;33011.504827428085;33124.1718957028;40641.796791015855;40763.59236407598;41551.42934277167;43331.35002974895;44418.77790611156;10589.576416943544;10619.30974486656;10668.253222274367;11139.33164010162;11294.265872718248;12185.817212741993;12277.69305767363;12501;12839;13065;11578.76842463163;11584.94207528957;11718;11992.340421276913;12144.271343719052;11068.723281918017;11108.346685509134;11269;11269.380184089627;11288.830667540158;11207.775844483227;11343.149263805082;11354.943225283821;11495.94252028768;11712.355820429959;9766.804663906823;9862.85205721929;9876.35803672759;10012.64955726546;10166.085052345325;9537.33238673314;9891.653792117242;9937.751556211153;10092.49958772456;10102.646407375707 11:08:33 INFO - PROCESS | 26705 | __end_tp_report 11:08:33 INFO - PROCESS | 26705 | __start_cc_report 11:08:33 INFO - PROCESS | 26705 | _x_x_mozilla_cycle_collect,1008 11:08:33 INFO - PROCESS | 26705 | __end_cc_report 11:08:33 INFO - PROCESS | 26705 | __startTimestamp1453489713408__endTimestamp 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | ------- Summary: start ------- 11:08:33 INFO - PROCESS | 26705 | Number of tests: 6 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#0] dojo.html Cycles:165 Average:5176.05 Median:5345.00 stddev:551.59 (10.3%) stddev-sans-first:530.50 11:08:33 INFO - PROCESS | 26705 | Values: 3176.1 3178.5 3218.1 3221.4 3247.5 5027.6 5080.9 5190.4 5210.8 5273.0 5176.2 5205.3 5232.5 5234.7 5272.0 4725.4 4766.7 4797.3 4813.4 4854.9 4832.0 4834.9 4862.3 4879.5 4886.4 4640.7 4680.9 4717.0 4768.8 4805.5 4767.3 4773.5 4778.0 4780.3 4815.2 4750.7 4759.1 4760.9 4769.1 4770.7 4910.2 4986.2 5047.1 5100.1 5154.8 5562.7 5564.7 5565.0 5571.8 5579.4 5598.8 5603.3 5606.4 5613.4 5615.8 5084.3 5158.4 5318.0 5376.0 5397.5 5711.1 5735.3 5749.1 5779.2 5803.2 5507.8 5513.0 5513.6 5526.6 5527.9 5345.0 5433.6 5584.6 5590.9 5677.8 5510.7 5518.2 5521.5 5521.8 5525.1 5483.9 5537.2 5540.0 5540.5 5590.0 4266.3 4324.9 4353.3 4393.1 4422.0 3855.1 3877.3 3884.1 3911.3 3920.8 5128.4 5136.2 5155.2 5162.3 5169.5 5347.4 5442.1 5563.8 5635.3 5652.1 5098.1 5127.9 5130.7 5132.5 5132.6 4647.4 4760.3 4763.9 4767.6 4813.3 5691.1 5692.3 5699.3 5725.3 5753.8 5619.9 5625.0 5628.5 5645.8 5647.7 5593.1 5670.5 5851.9 5874.0 5895.1 5519.9 5535.0 5539.1 5545.0 5589.3 5573.1 5595.9 5600.4 5610.4 5614.4 5308.2 5387.5 5473.1 5477.9 5493.9 5374.4 5392.9 5400.8 5400.9 5409.6 5308.9 5321.5 5328.9 5330.9 5332.0 5275.4 5315.4 5319.4 5353.2 5441.2 5361.7 5409.8 5413.9 5414.4 5454.6 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#1] ext.html Cycles:180 Average:45000.07 Median:19033.16 stddev:75461.52 (396.5%) stddev-sans-first:75599.35 11:08:33 INFO - PROCESS | 26705 | Values: 533.0 533.5 558.4 561.5 576.7 28349.6 29048.9 36264.5 36764.3 36831.8 42236.6 42794.4 42973.4 43061.6 43149.8 8487.8 8696.5 8698.0 8699.5 8699.7 8495.1 8629.8 8631.2 8632.1 8634.3 8614.2 8620.8 8705.4 8712.5 8718.5 8572.7 8638.4 8653.8 8661.7 8668.8 8460.9 8608.1 8613.1 8621.2 8629.5 39577.4 39985.0 40019.0 40084.0 40110.8 3489.0 3505.9 3599.1 3816.3 3888.0 26344.7 26738.2 26838.3 26844.9 27323.3 3428.9 3433.7 3444.3 3504.5 3580.9 253554.0 254799.0 255061.0 255930.0 256203.0 53338.0 54161.7 54351.2 58535.7 60230.0 55309.2 55533.0 55564.4 55580.4 55647.4 14990.6 15080.9 15083.7 15165.2 15184.0 10794.1 11316.3 11369.4 11374.3 11387.5 17010.7 19924.8 20498.0 20529.5 20559.9 7651.8 7799.0 7852.3 7889.5 7893.3 940.8 967.7 1014.6 1021.2 1035.6 26398.7 26836.3 27099.6 27158.9 27185.0 1033.3 1058.0 1067.2 1080.1 1150.5 14223.9 14599.0 14695.6 14789.0 14977.7 315914.0 319070.0 319903.0 320323.0 321125.0 51451.0 51664.7 51789.5 51903.2 51905.2 1306.0 1318.2 1320.2 1321.8 1328.7 26247.6 27596.4 27784.0 27961.9 28102.7 46311.0 46710.0 46800.5 46822.3 46898.3 284490.0 287487.0 288692.0 289206.0 289400.0 25580.5 27791.6 28576.4 32352.8 32636.2 37448.3 41260.0 42288.4 42728.4 43374.3 31621.7 32399.2 32687.7 33162.8 33365.3 32511.2 32885.7 34622.0 36283.5 36531.3 32764.0 34627.1 35292.5 35747.3 35793.0 27114.9 31260.2 31532.7 32524.3 32854.2 22679.0 23116.4 23552.6 23893.6 23917.4 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#2] jquery.html Cycles:180 Average:26925.01 Median:48348.52 stddev:87999.42 (182.0%) stddev-sans-first:88223.66 11:08:33 INFO - PROCESS | 26705 | Values: 351.7 355.3 365.7 367.2 372.8 13592.6 13736.7 15573.8 16761.7 17948.3 15968.4 16173.5 16637.7 16914.2 16919.4 5200.6 5413.5 5414.6 5415.6 5418.1 3933.9 4055.8 5253.9 5328.5 5695.3 5736.9 5744.7 5850.8 5857.5 5864.9 5747.1 5859.8 5869.4 5880.5 5880.6 5042.3 5194.7 5197.8 5217.1 5224.9 18757.8 19697.6 19761.3 19958.9 19987.9 2200.8 2201.5 2223.6 2263.5 2561.5 12325.6 12414.0 12567.0 12657.1 13105.7 1810.3 1812.9 1827.0 1829.8 1876.2 50313.2 50758.7 54390.7 56873.7 57003.7 9559.7 9849.4 10007.6 10020.8 10067.6 12978.9 13115.7 13249.5 13254.4 13257.2 7102.0 7183.4 7451.8 7555.4 7608.0 7295.5 7332.0 7349.1 7356.6 7385.4 4290.8 4397.8 4444.5 4450.2 4482.6 1671.8 1677.8 1717.0 1780.5 1793.5 913.5 946.9 968.5 973.3 977.7 15431.6 15478.8 16054.9 16258.3 16981.2 891.9 895.5 937.7 982.3 990.5 9266.9 9492.9 9743.6 9880.3 9919.2 423721.0 550188.0 557312.0 571858.0 579575.0 47744.3 48952.8 67588.0 72906.6 73183.3 1111.8 1143.4 1159.6 1160.7 1163.5 12283.7 13876.0 15083.8 15124.2 15181.0 31719.9 32655.2 32826.3 33373.2 33523.0 36648.0 38060.0 38095.4 38295.8 38778.8 7063.4 7256.3 7298.6 7368.5 7393.4 9102.2 10642.6 10674.9 10721.7 10929.1 8625.9 8806.9 9108.9 9488.0 9703.6 9748.4 9863.0 10061.9 10153.2 10153.7 9542.2 9930.0 9957.8 10106.8 10107.0 6982.9 7245.9 7255.1 7311.3 7358.0 8850.9 8985.9 9154.5 9468.9 9598.8 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#3] mootools.html Cycles:180 Average:5468.76 Median:6485.27 stddev:2824.45 (43.6%) stddev-sans-first:2815.59 11:08:33 INFO - PROCESS | 26705 | Values: 1373.0 1473.4 1480.8 1630.8 1773.8 6484.9 7654.9 7787.5 7794.6 7802.7 7548.2 7708.6 7711.7 7714.6 7719.3 1981.3 2031.8 2037.5 2285.5 2314.7 2307.8 2389.6 2389.9 2393.4 2394.8 2253.9 2281.5 2282.2 2286.4 2292.7 2289.6 2309.7 2312.7 2320.1 2330.8 2328.5 2330.3 2336.2 2346.6 2361.5 7836.3 7865.7 7866.4 7886.4 7888.8 4799.5 4878.3 4891.1 4911.6 4912.4 3067.2 3084.9 3096.3 3127.0 3132.4 978.5 992.7 996.0 1018.9 1034.3 10562.0 10599.5 10600.2 10614.9 10626.6 4306.0 4379.6 4396.4 4410.9 4442.1 9210.0 9226.9 9251.6 9278.4 9281.3 4775.6 4776.6 4784.8 4786.6 4788.9 4264.1 4265.0 4297.3 4303.7 4335.0 3416.7 3519.2 3735.6 3777.7 3804.9 1239.9 1247.7 1260.8 1271.1 1273.5 1183.0 1191.3 1196.8 1199.6 1222.2 7160.4 7249.9 7321.0 7328.0 7343.4 1019.8 1023.9 1037.3 1046.9 1051.6 5595.4 5619.3 5636.0 5666.9 5678.1 9112.7 9250.1 9329.6 9664.7 9678.4 9558.8 9679.9 9683.3 9692.8 9699.8 7230.2 7261.5 7434.8 7524.0 7526.4 7056.8 7079.9 7101.4 7108.3 7109.2 8305.6 8419.9 8427.9 8616.7 8621.1 8555.4 8852.8 8889.5 8891.9 8905.5 6814.1 6953.9 6963.3 6991.7 6993.0 6361.7 6473.5 6990.5 7158.2 7183.5 6659.7 6856.1 6918.7 7015.6 7079.2 6835.6 6877.0 6900.1 6963.7 7023.2 6908.8 6943.0 6950.7 6954.6 6956.0 6325.6 6485.6 6521.5 6522.2 6527.2 6569.8 6586.8 6611.9 6615.6 6620.3 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#4] prototype.html Cycles:180 Average:5203.85 Median:5836.91 stddev:1552.82 (26.6%) stddev-sans-first:1513.65 11:08:33 INFO - PROCESS | 26705 | Values: 339.7 348.8 351.7 355.8 357.9 5707.5 5827.8 5831.0 5837.9 5845.9 5627.7 5793.2 5817.5 5822.9 5826.7 4540.4 4554.1 4555.0 4559.5 4562.9 4363.2 4416.2 4469.3 4532.0 4553.6 4496.6 4496.8 4506.2 4509.2 4515.1 4504.2 4508.2 4514.8 4517.8 4521.7 3992.5 3994.9 3996.5 3996.6 4006.9 5402.4 5506.6 5513.2 5531.8 5540.3 5239.3 5242.3 5242.4 5255.5 5257.4 5875.6 6246.1 6251.0 6256.9 6257.7 4180.9 4277.8 4382.0 4392.4 4394.3 6362.7 6457.5 6458.4 6462.6 6462.8 4473.6 4474.8 4476.8 4478.7 4482.2 4468.1 4538.5 4541.0 4546.6 4559.2 5199.7 5209.2 5215.7 5217.1 5218.6 6197.8 6200.4 6213.6 6214.2 6225.5 1571.5 1592.9 1592.9 1594.3 1596.5 1067.2 1075.3 1086.6 1087.8 1110.6 5835.9 5850.9 5852.3 5853.8 5856.2 6376.0 6389.6 6392.6 6393.4 6396.1 5700.4 5835.8 5843.9 5846.1 5854.2 3307.8 3419.5 3424.8 3425.4 3426.5 6629.4 6648.0 6652.9 6659.1 6659.3 6498.3 6504.4 6507.8 6512.7 6519.0 6543.4 6637.4 6741.2 6745.5 6750.8 6150.9 6327.9 6434.4 6502.4 6504.4 6216.9 6368.2 6370.9 6376.5 6390.3 6708.2 6718.6 6718.6 6719.4 6725.4 4352.5 4474.7 4509.1 4539.5 4542.6 6385.2 6393.5 6398.9 6400.1 6405.9 6223.0 6233.7 6234.3 6235.5 6236.1 6047.9 6212.3 6225.2 6226.1 6230.1 6078.9 6101.4 6107.1 6167.8 6178.0 6274.1 6286.5 6288.3 6293.9 6295.7 5937.6 6144.1 6146.3 6154.0 6156.8 11:08:33 INFO - PROCESS | 26705 | 11:08:33 INFO - PROCESS | 26705 | [#5] yui.html Cycles:180 Average:13636.88 Median:42441.39 stddev:15764.59 (37.1%) stddev-sans-first:15779.19 11:08:33 INFO - PROCESS | 26705 | Values: 768.0 791.1 800.7 821.8 854.0 13444.7 13587.3 13605.7 13633.3 13650.0 12718.9 12778.6 12788.1 12792.1 12837.0 658.7 661.3 776.9 791.8 793.3 794.2 794.2 801.2 802.8 803.2 830.4 831.3 831.4 833.2 838.4 680.4 681.5 829.2 831.6 839.1 605.9 614.9 619.0 621.3 622.7 12812.6 12909.1 12930.5 12943.2 13022.5 12953.4 13099.5 13139.0 13266.6 13391.9 9859.2 10006.3 10028.2 10158.8 10270.2 3510.4 3545.3 3548.4 3580.2 3693.2 46016.5 46259.5 46282.5 46371.3 46393.8 10053.5 10301.5 10371.7 10456.5 10558.9 18434.3 18434.7 18446.5 18498.2 18548.1 6789.4 7058.2 7089.0 7136.1 7160.7 4051.8 4076.8 4083.0 4105.3 4129.6 2855.5 2861.1 2863.5 2870.3 2883.4 516.0 531.8 539.0 540.8 543.2 552.3 615.2 646.5 646.5 650.2 8105.6 8248.7 8266.5 8337.7 8445.3 466.6 496.4 497.0 502.2 502.4 3716.8 3814.2 3830.9 3867.4 4068.1 56364.0 60371.0 62776.4 63355.4 63379.0 46556.3 46983.5 48352.3 50992.0 51288.5 44501.6 44903.3 45616.3 46931.3 47061.0 8769.9 8908.9 9148.9 9171.9 9226.7 31724.8 32337.0 32797.7 33011.5 33124.2 40641.8 40763.6 41551.4 43331.4 44418.8 10589.6 10619.3 10668.3 11139.3 11294.3 12185.8 12277.7 12501.0 12839.0 13065.0 11578.8 11584.9 11718.0 11992.3 12144.3 11068.7 11108.3 11269.0 11269.4 11288.8 11207.8 11343.1 11354.9 11495.9 11712.4 9766.8 9862.9 9876.4 10012.6 10166.1 9537.3 9891.7 9937.8 10092.5 10102.6 11:08:33 INFO - PROCESS | 26705 | -------- Summary: end -------- 11:08:33 INFO - PROCESS | 26705 | 11:08:34 INFO - TEST-INFO | 26705: exit 0 11:08:34 INFO - TEST-OK | dromaeo_css | took 1112887ms 11:08:34 INFO - TEST-START | kraken 11:08:34 INFO - operating with platform_type : linux_ 11:08:34 INFO - Initialising browser for kraken test... 11:08:34 INFO - TEST-INFO | started process 26899 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBYstFU/profile http://localhost:56136/getInfo.html) 11:08:37 INFO - PROCESS | 26899 | __metrics Screen width/height:1600/1200 11:08:37 INFO - PROCESS | 26899 | colorDepth:24 11:08:37 INFO - PROCESS | 26899 | Browser inner width/height: 1024/697 11:08:37 INFO - PROCESS | 26899 | __metrics 11:08:37 INFO - PROCESS | 26899 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:08:37 INFO - PROCESS | 26899 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:08:38 INFO - TEST-INFO | 26899: exit 0 11:08:38 INFO - Browser initialized. 11:08:38 INFO - Running cycle 1/1 for kraken test... 11:08:38 INFO - TEST-INFO | started process 26980 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBYstFU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:50 INFO - PROCESS | 26980 | RSS: Main: 147963904 11:08:50 INFO - PROCESS | 26980 | 11:08:53 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56136/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:53 INFO - PROCESS | 26980 | RSS: Main: 187801600 11:08:53 INFO - PROCESS | 26980 | 11:08:56 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56136/tests/kraken/driver.html?testName=audio-dft) 11:08:57 INFO - PROCESS | 26980 | RSS: Main: 179773440 11:08:57 INFO - PROCESS | 26980 | 11:09:00 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56136/tests/kraken/driver.html?testName=audio-fft) 11:09:00 INFO - PROCESS | 26980 | RSS: Main: 161660928 11:09:00 INFO - PROCESS | 26980 | 11:09:02 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56136/tests/kraken/driver.html?testName=audio-oscillator) 11:09:03 INFO - PROCESS | 26980 | RSS: Main: 166060032 11:09:03 INFO - PROCESS | 26980 | 11:09:05 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:05 INFO - PROCESS | 26980 | RSS: Main: 168079360 11:09:05 INFO - PROCESS | 26980 | 11:09:08 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56136/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:09 INFO - PROCESS | 26980 | RSS: Main: 168407040 11:09:09 INFO - PROCESS | 26980 | 11:09:12 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56136/tests/kraken/driver.html?testName=imaging-desaturate) 11:09:13 INFO - PROCESS | 26980 | RSS: Main: 167235584 11:09:13 INFO - PROCESS | 26980 | 11:09:16 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56136/tests/kraken/driver.html?testName=json-parse-financial) 11:09:16 INFO - PROCESS | 26980 | RSS: Main: 169455616 11:09:16 INFO - PROCESS | 26980 | 11:09:18 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:09:18 INFO - PROCESS | 26980 | RSS: Main: 178139136 11:09:18 INFO - PROCESS | 26980 | 11:09:20 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:09:21 INFO - PROCESS | 26980 | RSS: Main: 178286592 11:09:21 INFO - PROCESS | 26980 | 11:09:23 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:09:23 INFO - PROCESS | 26980 | RSS: Main: 186048512 11:09:23 INFO - PROCESS | 26980 | 11:09:26 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:09:26 INFO - PROCESS | 26980 | RSS: Main: 194166784 11:09:26 INFO - PROCESS | 26980 | 11:09:29 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:09:29 INFO - PROCESS | 26980 | RSS: Main: 194580480 11:09:29 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | Cycle 1(1): loaded http://localhost:56136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56136/tests/kraken/driver.html?testName=ai-astar) 11:09:31 INFO - PROCESS | 26980 | RSS: Main: 255143936 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | __start_tp_report 11:09:31 INFO - PROCESS | 26980 | _x_x_mozilla_page_load 11:09:31 INFO - PROCESS | 26980 | _x_x_mozilla_page_load_details 11:09:31 INFO - PROCESS | 26980 | |i|pagename|runs| 11:09:31 INFO - PROCESS | 26980 | |0;ai-astar;110;111;104;112;109;113;111;110;104;110 11:09:31 INFO - PROCESS | 26980 | |1;audio-beat-detection;149;130;153;167;125;158;161;128;163;124 11:09:31 INFO - PROCESS | 26980 | |2;audio-dft;161;160;160;160;160;163;161;159;162;162 11:09:31 INFO - PROCESS | 26980 | |3;audio-fft;74;73;98;94;72;72;73;115;92;73 11:09:31 INFO - PROCESS | 26980 | |4;audio-oscillator;104;96;150;96;96;95;141;95;95;140 11:09:31 INFO - PROCESS | 26980 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;109 11:09:31 INFO - PROCESS | 26980 | |6;imaging-darkroom;146;145;145;145;146;146;145;148;145;146 11:09:31 INFO - PROCESS | 26980 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;95;95 11:09:31 INFO - PROCESS | 26980 | |8;json-parse-financial;57;54;54;55;54;55;56;55;54;52 11:09:31 INFO - PROCESS | 26980 | |9;json-stringify-tinderbox;68;67;67;68;68;69;69;68;69;68 11:09:31 INFO - PROCESS | 26980 | |10;stanford-crypto-aes;83;83;84;86;86;82;82;83;82;83 11:09:31 INFO - PROCESS | 26980 | |11;stanford-crypto-ccm;118;116;116;112;121;123;116;113;118;117 11:09:31 INFO - PROCESS | 26980 | |12;stanford-crypto-pbkdf2;143;143;153;145;143;132;144;141;143;143 11:09:31 INFO - PROCESS | 26980 | |13;stanford-crypto-sha256-iterative;69;67;67;67;66;67;65;68;67;66 11:09:31 INFO - PROCESS | 26980 | __end_tp_report 11:09:31 INFO - PROCESS | 26980 | __start_cc_report 11:09:31 INFO - PROCESS | 26980 | _x_x_mozilla_cycle_collect,950 11:09:31 INFO - PROCESS | 26980 | __end_cc_report 11:09:31 INFO - PROCESS | 26980 | __startTimestamp1453489771926__endTimestamp 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | ------- Summary: start ------- 11:09:31 INFO - PROCESS | 26980 | Number of tests: 14 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.50 stddev:3.06 (2.8%) stddev-sans-first:3.24 11:09:31 INFO - PROCESS | 26980 | Values: 110.0 111.0 104.0 112.0 109.0 113.0 111.0 110.0 104.0 110.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:155.50 stddev:17.20 (11.1%) stddev-sans-first:18.20 11:09:31 INFO - PROCESS | 26980 | Values: 149.0 130.0 153.0 167.0 125.0 158.0 161.0 128.0 163.0 124.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 11:09:31 INFO - PROCESS | 26980 | Values: 161.0 160.0 160.0 160.0 160.0 163.0 161.0 159.0 162.0 162.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#3] audio-fft Cycles:10 Average:83.60 Median:73.50 stddev:15.17 (20.6%) stddev-sans-first:15.68 11:09:31 INFO - PROCESS | 26980 | Values: 74.0 73.0 98.0 94.0 72.0 72.0 73.0 115.0 92.0 73.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:95.00 stddev:22.98 (24.2%) stddev-sans-first:24.24 11:09:31 INFO - PROCESS | 26980 | Values: 104.0 96.0 150.0 96.0 96.0 95.0 141.0 95.0 95.0 140.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:09:31 INFO - PROCESS | 26980 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 11:09:31 INFO - PROCESS | 26980 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 148.0 145.0 146.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 11:09:31 INFO - PROCESS | 26980 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 95.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.12 11:09:31 INFO - PROCESS | 26980 | Values: 57.0 54.0 54.0 55.0 54.0 55.0 56.0 55.0 54.0 52.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 11:09:31 INFO - PROCESS | 26980 | Values: 68.0 67.0 67.0 68.0 68.0 69.0 69.0 68.0 69.0 68.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 11:09:31 INFO - PROCESS | 26980 | Values: 83.0 83.0 84.0 86.0 86.0 82.0 82.0 83.0 82.0 83.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.50 stddev:3.30 (2.8%) stddev-sans-first:3.48 11:09:31 INFO - PROCESS | 26980 | Values: 118.0 116.0 116.0 112.0 121.0 123.0 116.0 113.0 118.0 117.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:143.00 stddev:5.06 (3.5%) stddev-sans-first:5.36 11:09:31 INFO - PROCESS | 26980 | Values: 143.0 143.0 153.0 145.0 143.0 132.0 144.0 141.0 143.0 143.0 11:09:31 INFO - PROCESS | 26980 | 11:09:31 INFO - PROCESS | 26980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.10 (1.6%) stddev-sans-first:0.87 11:09:31 INFO - PROCESS | 26980 | Values: 69.0 67.0 67.0 67.0 66.0 67.0 65.0 68.0 67.0 66.0 11:09:31 INFO - PROCESS | 26980 | -------- Summary: end -------- 11:09:31 INFO - PROCESS | 26980 | 11:09:32 INFO - TEST-INFO | 26980: exit 0 11:09:32 INFO - TEST-OK | kraken | took 58748ms 11:09:32 INFO - TEST-START | v8_7 11:09:32 INFO - operating with platform_type : linux_ 11:09:32 INFO - Initialising browser for v8_7 test... 11:09:32 INFO - TEST-INFO | started process 27227 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3av_6V/profile http://localhost:56136/getInfo.html) 11:09:36 INFO - PROCESS | 27227 | __metrics Screen width/height:1600/1200 11:09:36 INFO - PROCESS | 27227 | colorDepth:24 11:09:36 INFO - PROCESS | 27227 | Browser inner width/height: 1024/697 11:09:36 INFO - PROCESS | 27227 | __metrics 11:09:36 INFO - PROCESS | 27227 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:09:36 INFO - PROCESS | 27227 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:37 INFO - TEST-INFO | 27227: exit 0 11:09:37 INFO - Browser initialized. 11:09:37 INFO - Running cycle 1/1 for v8_7 test... 11:09:37 INFO - TEST-INFO | started process 27309 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3av_6V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:49 INFO - PROCESS | 27309 | RSS: Main: 148996096 11:09:49 INFO - PROCESS | 27309 | 11:10:11 INFO - PROCESS | 27309 | Cycle 1(1): loaded http://localhost:56136/tests/v8_7/run.html (next: http://localhost:56136/tests/v8_7/run.html) 11:10:12 INFO - PROCESS | 27309 | RSS: Main: 572522496 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | __start_tp_report 11:10:12 INFO - PROCESS | 27309 | _x_x_mozilla_page_load 11:10:12 INFO - PROCESS | 27309 | _x_x_mozilla_page_load_details 11:10:12 INFO - PROCESS | 27309 | |i|pagename|runs| 11:10:12 INFO - PROCESS | 27309 | |0;Richards;167.36401673640168 11:10:12 INFO - PROCESS | 27309 | |1;DeltaBlue;191.38755980861245 11:10:12 INFO - PROCESS | 27309 | |2;Encrypt;280.0336040324839 11:10:12 INFO - PROCESS | 27309 | |3;Decrypt;5196.891191709845 11:10:12 INFO - PROCESS | 27309 | |4;RayTrace;1114.6993318485524 11:10:12 INFO - PROCESS | 27309 | |5;Earley;798.7220447284345 11:10:12 INFO - PROCESS | 27309 | |6;Boyer;12370.37037037037 11:10:12 INFO - PROCESS | 27309 | |7;RegExp;42125 11:10:12 INFO - PROCESS | 27309 | |8;Splay;611.2469437652812 11:10:12 INFO - PROCESS | 27309 | |9;NavierStokes;4835.748792270531 11:10:12 INFO - PROCESS | 27309 | __end_tp_report 11:10:12 INFO - PROCESS | 27309 | __startTimestamp1453489812247__endTimestamp 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | ------- Summary: start ------- 11:10:12 INFO - PROCESS | 27309 | Number of tests: 10 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 167.4 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 191.4 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 280.0 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 5196.9 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#4] RayTrace Cycles:1 Average:1114.70 Median:1114.70 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 1114.7 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 798.7 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 12370.4 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#7] RegExp Cycles:1 Average:42125.00 Median:42125.00 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 42125.0 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#8] Splay Cycles:1 Average:611.25 Median:611.25 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 611.2 11:10:12 INFO - PROCESS | 27309 | 11:10:12 INFO - PROCESS | 27309 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:10:12 INFO - PROCESS | 27309 | Values: 4835.7 11:10:12 INFO - PROCESS | 27309 | -------- Summary: end -------- 11:10:12 INFO - PROCESS | 27309 | 11:10:13 INFO - TEST-INFO | 27309: exit 0 11:10:13 INFO - TEST-OK | v8_7 | took 40236ms 11:10:13 INFO - SUITE-END | took 1211s 11:10:13 INFO - Completed test suite (00:20:12) 11:10:13 INFO - Working with test: dromaeo_css 11:10:13 INFO - Generating results file: dromaeo_css 11:10:13 INFO - Working with test: kraken 11:10:13 INFO - Generating results file: kraken 11:10:13 INFO - javascript benchmark 11:10:13 INFO - Working with test: v8_7 11:10:13 INFO - Generating results file: v8_7 11:10:13 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 11:10:13 INFO - process_Request line: dromaeo_css 6786.22 graph.html#tests=[[72,64,35]] 11:10:13 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:13 INFO - process_Request line: kraken 1494.10 graph.html#tests=[[232,64,35]] 11:10:13 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:10:13 INFO - process_Request line: v8_7 19931.96 graph.html#tests=[[230,64,35]] 11:10:13 INFO - RETURN: dromaeo_css: 6786.22 11:10:13 INFO - RETURN: kraken: 1494.10 11:10:13 INFO - RETURN: v8_7: 19931.96 11:10:13 INFO - javascript benchmark 11:10:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3176.126565194572, 3178.5073313636367, 3218.115018369948, 3221.3557288542283, 3247.464168412212, 5027.597792176626, 5080.8983820323665, 5190.403103643082, 5210.780719213448, 5273.0, 5176.249443830642, 5205.297284866542, 5232.45059268777, 5234.7120908350025, 5271.973640131803, 4725.362076119714, 4766.690165139272, 4797.328374027639, 4813.374261346037, 4854.927176092361, 4832.0, 4834.854954351375, 4862.34358361622, 4879.51204879511, 4886.413630364361, 4640.721556706591, 4680.9297860532115, 4716.952830471686, 4768.761561921925, 4805.471398146201, 4767.261074533453, 4773.474917759044, 4778.020505796303, 4780.330753694486, 4815.22956326986, 4750.738709370983, 4759.095771803381, 4760.857174284777, 4769.093872164312, 4770.689905156154, 4910.1898186799135, 4986.152354099811, 5047.066292735855, 5100.081985242655, 5154.845354639367, 5562.666240025571, 5564.693941833198, 5565.0, 5571.832845014656, 5579.442055794388, 5598.832035038955, 5603.271574695264, 5606.439356064402, 5613.410591887834, 5615.831525054214, 5084.288199652052, 5158.3552055993005, 5318.0, 5376.0, 5397.514223719805, 5711.086226203871, 5735.283089613798, 5749.051406517961, 5779.219805326311, 5803.245578074823, 5507.752151153208, 5513.0, 5513.558915286848, 5526.613137080366, 5527.889442211133, 5345.0, 5433.619646624698, 5584.636998595079, 5590.86022849432, 5677.772889084473, 5510.6969116698965, 5518.172274158908, 5521.5306698930235, 5521.834344969658, 5525.060739674265, 5483.917741233885, 5537.224788529609, 5539.972300138554, 5540.529055030287, 5590.0, 4266.2960611499375, 4324.891877703082, 4353.32523458858, 4393.055493069006, 4421.977890110529, 3855.0747820523434, 3877.2827027000094, 3884.067823722343, 3911.2568611963634, 3920.843166273317, 5128.435872054071, 5136.178211486144, 5155.175171972466, 5162.328897243335, 5169.4572069932865, 5347.438518955531, 5442.074847275972, 5563.833085007456, 5635.295588051494, 5652.123920792284, 5098.08234517783, 5127.8718032048755, 5130.743462826844, 5132.5124113209185, 5132.615053870974, 4647.37260469839, 4760.33355330254, 4763.857084287477, 4767.642426818003, 4813.278008298713, 5691.089425691952, 5692.260006199251, 5699.287589051369, 5725.2843394575675, 5753.798617048383, 5619.887602247851, 5624.971875140598, 5628.465295796893, 5645.802396916089, 5647.717614119196, 5593.07714227148, 5670.5180059695385, 5851.912221316768, 5873.970630146822, 5895.086261629454, 5519.9448005521035, 5535.0313695104005, 5539.058360078877, 5545.0, 5589.273394458857, 5573.080441727232, 5595.8880822384135, 5600.383957764561, 5610.382857885547, 5614.354349249888, 5308.203769434615, 5387.542058925035, 5473.0969390050195, 5477.945220547744, 5493.917591236055, 5374.355077390738, 5392.865178370572, 5400.810971616132, 5400.9459905400445, 5409.648372855751, 5308.893822123613, 5321.467853214647, 5328.920066198933, 5330.946690533045, 5332.0, 5275.366955965309, 5315.3621565412395, 5319.38827034896, 5353.22378255143, 5441.21102440136, 5361.731913404236, 5409.810656626999, 5413.918791218056, 5414.431484694208, 5454.618176727591], "unit": "score", "name": "dojo.html", "value": 5142.225146771923}, {"lowerIsBetter": false, "replicates": [532.9626926115171, 533.5331584863245, 558.3662543013678, 561.531121513536, 576.723172877019, 28349.574756378646, 29048.854755726217, 36264.45603315949, 36764.26471470569, 36831.81584092076, 42236.57763422365, 42794.35808462876, 42973.35539966895, 43061.569384306145, 43149.78425107878, 8487.78780530487, 8696.47821130731, 8698.043215246318, 8699.478031318142, 8699.652013919467, 8495.065542790288, 8629.784255393603, 8631.223189912907, 8632.13678632138, 8634.26608738258, 8614.18165274298, 8620.784480387978, 8705.390622656416, 8712.477251364906, 8718.520481373522, 8572.742817715478, 8638.352123590694, 8653.826923461558, 8661.653533858638, 8668.826623467527, 8460.915390846074, 8608.053114157437, 8613.095624959415, 8621.224089831883, 8629.482231066093, 39577.40633890494, 39985.0, 40019.0, 40084.0, 40110.788367221605, 3489.0, 3505.8948231553095, 3599.0642432967616, 3816.255830113129, 3887.9502534315575, 26344.73655263442, 26738.19785406441, 26838.329041773915, 26844.865775670998, 27323.316917077034, 3428.8971330860113, 3433.6909678128836, 3444.328355970587, 3504.4918486819524, 3580.9104772380897, 253554.0, 254798.99999999814, 255061.0, 255930.0, 256203.0, 53338.0, 54161.72919135458, 54351.18473222905, 58535.707321463124, 60230.0, 55309.170362443794, 55533.0, 55564.44435555593, 55580.444195557524, 55647.44352556504, 14990.550283491513, 15080.924595376953, 15083.698326033636, 15165.24173791328, 15184.0, 10794.136469082454, 11316.26444281119, 11369.374684392273, 11374.260673056391, 11387.544498219979, 17010.744838827428, 19924.800751992294, 20498.0, 20529.48676283075, 20559.8972005139, 7651.770446886602, 7799.0, 7852.254035866584, 7889.526628402315, 7893.289603935674, 940.7507010642186, 967.6806653804227, 1014.629660174046, 1021.1575450253571, 1035.5961175141701, 26398.736012640013, 26836.32909177247, 27099.593506097423, 27158.913643454434, 27185.0, 1033.3283365812283, 1057.9735506612242, 1067.2315932528568, 1080.0657431322006, 1150.4765331774022, 14223.85776142246, 14599.0, 14695.632609184855, 14789.0, 14977.700445991019, 315914.0, 319070.0, 319903.0, 320323.0, 321125.0, 51451.0, 51664.74167629138, 51789.48210517922, 51903.221451678255, 51905.183318583666, 1305.9869401306055, 1318.2156616812981, 1320.2210695689398, 1321.8017297405274, 1328.6545498170544, 26247.60628590611, 27596.448071038867, 27784.0, 27961.860190698917, 28102.71897281001, 46311.0, 46710.0, 46800.531994679615, 46822.29766553573, 46898.296525552825, 284490.0, 287487.0, 288692.0, 289206.0, 289400.0, 25580.488390232462, 27791.583126252717, 28576.42847143087, 32352.83823580867, 32636.184095397806, 37448.251034979694, 41260.0, 42288.365674515524, 42728.35907461453, 43374.34938475989, 31621.683783161872, 32399.190020249684, 32687.67312326846, 33162.83418582891, 33365.332693346485, 32511.187220318734, 32885.67114328826, 34622.0, 36283.45574816433, 36531.26937461289, 32764.0, 34627.134321641155, 35292.47061294031, 35747.28505429929, 35793.0, 27114.864425677744, 31260.218494537818, 31532.684673153894, 32524.349513009132, 32854.178645534055, 22679.0, 23116.422089447897, 23552.6467102997, 23893.641595375735, 23917.402064948514], "unit": "score", "name": "ext.html", "value": 17908.43102638344}, {"lowerIsBetter": false, "replicates": [351.7098393825094, 355.3213362477667, 365.67272291299287, 367.2013370918252, 372.8452692132765, 13592.592222233348, 13736.725265494684, 15573.844261557395, 16761.66476670466, 17948.282068717235, 15968.441104561314, 16173.514794556182, 16637.667246655088, 16914.1542922854, 16919.407820726276, 5200.583953283738, 5413.539849112811, 5414.620976531624, 5415.620906536544, 5418.051840927842, 3933.8819835404843, 4055.797210139481, 5253.868653283679, 5328.5470734987375, 5695.345035320929, 5736.885262294752, 5744.702119152331, 5850.76596936122, 5857.502112320458, 5864.941350586503, 5747.08046712524, 5859.7949071782705, 5869.442402971711, 5880.5295576354, 5880.55895807814, 5042.294078828967, 5194.740262986836, 5197.818076367347, 5217.139172036609, 5224.869378265574, 18757.780744251715, 19697.606047879104, 19761.30835420768, 19958.900205498878, 19987.900060499604, 2200.8459407841456, 2201.460642142685, 2223.633100538409, 2263.479399738053, 2561.526117668219, 12325.630231093082, 12414.0, 12567.0, 12657.114002019862, 13105.672358191026, 1810.2849374497132, 1812.8821626594229, 1826.97259541107, 1829.7712785901763, 1876.2119909637984, 50313.24530132051, 50758.746206269105, 54390.72804635991, 56873.715631421575, 57003.71498142524, 9559.665411710557, 9849.359791613522, 10007.599696012223, 10020.849687254697, 10067.647632332833, 12978.870211297955, 13115.737685246433, 13249.536266230636, 13254.40355184019, 13257.204567725967, 7101.964490177619, 7183.353498185188, 7451.813704657318, 7555.357794587521, 7608.0489938757655, 7295.489315747953, 7331.951259526611, 7349.081364829396, 7356.558606483628, 7385.409167266605, 4290.849820256339, 4397.802098905557, 4444.511103778582, 4450.242154349079, 4482.574155455227, 1671.8411750883647, 1677.8070521889895, 1716.9914150429167, 1780.5250701524633, 1793.5247159502742, 913.5249670171606, 946.8958414574391, 968.5157421289356, 973.2603221551531, 977.745786095606, 15431.61420964485, 15478.767818482731, 16054.919725401533, 16258.349666013228, 16981.150942452827, 891.9152680495342, 895.4716717136921, 937.6624415210518, 982.29274922056, 990.4601991914424, 9266.907330926739, 9492.857607135898, 9743.561539730728, 9880.308378413441, 9919.206463482904, 423721.0, 550188.0, 557312.0, 571858.0, 579575.0, 47744.28383574249, 48952.75523622359, 67588.0, 72906.63546682338, 73183.2681673187, 1111.7832022755485, 1143.422571601336, 1159.6405114414558, 1160.721426857548, 1163.4531770068224, 12283.69290767738, 13876.0, 15083.773743394077, 15124.168170750714, 15181.0, 31719.889803856753, 32655.18362040968, 32826.34347313088, 33373.16567085745, 33523.0, 36648.0, 38060.0, 38095.42856857094, 38295.80852095833, 38778.80610596929, 7063.364297213276, 7256.310650488195, 7298.613263479921, 7368.484206105735, 7393.371563416955, 9102.24996645193, 10642.62750803749, 10674.946625266824, 10721.731956700833, 10929.071028962628, 8625.8706119407, 8806.91193088061, 9108.904951860977, 9487.95256023743, 9703.611855525982, 9748.415095094317, 9863.01369863008, 10061.949690251502, 10153.238507111848, 10153.746156345855, 9542.236621070437, 9930.0, 9957.820111687384, 10106.797864042825, 10107.0, 6982.860342793218, 7245.927540724525, 7255.09311336083, 7311.305425984523, 7358.0, 8850.867236991578, 8985.910140898508, 9154.496502692416, 9468.905310946802, 9598.808023839623], "unit": "score", "name": "jquery.html", "value": 8123.110893482413}, {"lowerIsBetter": false, "replicates": [1372.997711670481, 1473.4106357457015, 1480.822301323841, 1630.845069718377, 1773.8226177382255, 6484.902726459107, 7654.923450765491, 7787.532748035122, 7794.610269486531, 7802.687892484294, 7548.245175482449, 7708.5760283184545, 7711.730089446871, 7714.575698336589, 7719.343855772266, 1981.3065427100544, 2031.7968203179637, 2037.4600730806349, 2285.5200407914317, 2314.6875171851752, 2307.826912981533, 2389.64155376694, 2389.916352927648, 2393.3896856301617, 2394.8443351182204, 2253.86476811391, 2281.53228588139, 2282.2354511238673, 2286.4398222435443, 2292.713410823647, 2289.587874182638, 2309.711286089239, 2312.6877871487304, 2320.1183550250967, 2330.8484948478294, 2328.464453175779, 2330.3358542815217, 2336.217367181979, 2346.636271377939, 2361.4568649210605, 7836.333911617519, 7865.68537258509, 7866.410019248522, 7886.369090472748, 7888.7633370998965, 4799.496052914464, 4878.268259761029, 4891.070696567641, 4911.631627627942, 4912.38595175603, 3067.1871953932227, 3084.948509241352, 3096.349766549005, 3126.98436507816, 3132.420502207099, 978.4667356290838, 992.7121134870879, 996.038822536256, 1018.9286749927508, 1034.3173505486418, 10562.0, 10599.523021464052, 10600.204984626107, 10614.893851061468, 10626.574937002511, 4306.0, 4379.58393952574, 4396.384506169139, 4410.867673969722, 4442.111577684412, 9209.95395023034, 9226.86159707605, 9251.629934802533, 9278.396904201205, 9281.257499400032, 4775.594074503637, 4776.593989510861, 4784.760761961888, 4786.593139583105, 4788.880277993008, 4264.061906380592, 4264.978675106605, 4297.333913243452, 4303.74177549348, 4335.024619460596, 3416.7437442191936, 3519.240379810095, 3735.6264373562426, 3777.6788972937607, 3804.9429258561145, 1239.8512178538454, 1247.7255003899127, 1260.836091308124, 1271.0784681106124, 1273.4651446392538, 1183.0358258019687, 1191.3447603817865, 1196.8324434579165, 1199.580146948561, 1222.2177806204036, 7160.355567998905, 7249.855002900018, 7320.96339518299, 7328.0, 7343.449241306924, 1019.8317277649253, 1023.8515415264745, 1037.3205550364523, 1046.942418167008, 1051.6056478820442, 5595.440455954372, 5619.325680918316, 5636.013697602985, 5666.914996275059, 5678.0915053591225, 9112.681056163003, 9250.121238482468, 9329.626814927462, 9664.661736839176, 9678.419294842332, 9558.761030974281, 9679.854802177973, 9683.273754468442, 9692.806143877084, 9699.817541053348, 7230.2046774854725, 7261.5280006799385, 7434.814129646694, 7524.021877156044, 7526.360259378014, 7056.82357941035, 7079.8938015930835, 7101.431885449048, 7108.253633368422, 7109.1824440187975, 8305.626246819029, 8419.915800842158, 8427.915720842713, 8616.698415555426, 8621.09478504748, 8555.401121921406, 8852.822943541221, 8889.4666320021, 8891.866622000545, 8905.51019693897, 6814.1482314710665, 6953.930460695531, 6963.338482844122, 6991.6853741580735, 6993.0, 6361.745530178741, 6473.514486413444, 6990.545614535039, 7158.176809666955, 7183.5330703504105, 6659.700313485808, 6856.142982127234, 6918.688659010256, 7015.614141222078, 7079.221285658677, 6835.58986460794, 6876.965615171892, 6900.068490753684, 6963.6866341013765, 7023.157221133497, 6908.827279318058, 6942.965285173542, 6950.687219075053, 6954.617496037767, 6955.965220173866, 6325.620462772248, 6485.643289619116, 6521.5108866834225, 6522.21733391977, 6527.249366322933, 6569.770058047945, 6586.769463068769, 6611.867762644816, 6615.6030638161865, 6620.304867988792], "unit": "score", "name": "mootools.html", "value": 4501.163744694224}, {"lowerIsBetter": false, "replicates": [339.7248228934563, 348.8186143205533, 351.73795522335854, 355.8098161649285, 357.9480975258586, 5707.486326230638, 5827.796027139051, 5831.0, 5837.941620583793, 5845.912311315328, 5627.6904770237625, 5793.188953546507, 5817.476427121558, 5822.854428639275, 5826.737796799154, 4540.409746732928, 4554.111948170108, 4554.97722511387, 4559.54404559543, 4562.8631141065825, 4363.170997510463, 4416.183006143858, 4469.3296005599095, 4531.977340113295, 4553.612942899857, 4496.617787488068, 4496.752678602676, 4506.188886000535, 4509.1658043262105, 4515.051839113774, 4504.166729155117, 4508.188526065307, 4514.774261286939, 4517.796699148514, 4521.683482156251, 3992.5208974923194, 3994.9201015979806, 3996.540397854255, 3996.620321069494, 4006.9198616027807, 5402.35171779385, 5506.614536982413, 5513.228148059275, 5531.834044978657, 5540.307461567304, 5239.266502689627, 5242.318498595197, 5242.423333433319, 5255.500727430888, 5257.447967963385, 5875.6474611523445, 6246.0630905364105, 6250.9998400255745, 6256.874862502725, 6257.687115644245, 4180.937285940713, 4277.807498662568, 4382.035952090535, 4392.385066090718, 4394.318880573516, 6362.745490180388, 6457.515686323498, 6458.354164583551, 6462.644554549545, 6462.806115816533, 4473.642108631302, 4474.79863406141, 4476.798544065459, 4478.7088839226, 4482.238019536687, 4468.106378724203, 4538.500764915857, 4541.046380260183, 4546.636269098531, 4559.156556037144, 5199.74001299941, 5209.192575150858, 5215.6609820361555, 5217.087009773274, 5218.582513398919, 6197.845053873689, 6200.410960958701, 6213.627182368982, 6214.223222097238, 6225.501959843202, 1571.4578470427684, 1592.8805339599576, 1592.912389818548, 1594.3224129744813, 1596.5449846793608, 1067.1836045425257, 1075.3118004477142, 1086.576235268246, 1087.8096333141668, 1110.6334909479851, 5835.883282334329, 5850.8537286567325, 5852.268466441695, 5853.795117170878, 5856.238688970407, 6376.043593461018, 6389.5846769960735, 6392.616443013434, 6393.392627700361, 6396.0725694774, 5700.429957004267, 5835.824925252249, 5843.853903652358, 5846.064629659234, 5854.18041474194, 3307.8015319080932, 3419.452887537982, 3424.845881935319, 3425.3663072331697, 3426.468897320919, 6629.436497897733, 6648.0, 6652.900206496906, 6659.067730517731, 6659.334066593302, 6498.285188629247, 6504.382083702136, 6507.772227971998, 6512.706928188243, 6518.9569668852755, 6543.411093001652, 6637.369449902251, 6741.22475915276, 6745.460363170934, 6750.797476075725, 6150.907736383869, 6327.905081423874, 6434.356564343529, 6502.414782669583, 6504.38208370204, 6216.937830621636, 6368.172137622079, 6370.936290637034, 6376.458001069961, 6390.265119511316, 6708.228553716385, 6718.563293385914, 6718.596884186964, 6719.428848547733, 6725.361090696376, 4352.477702675699, 4474.709143905636, 4509.098180363875, 4539.455265368177, 4542.568455996675, 6385.233771947396, 6393.456556192589, 6398.93601064002, 6400.071989561395, 6405.8718825624155, 6222.968885155546, 6233.688315584293, 6234.345393733593, 6235.46998505114, 6236.064590311489, 6047.9395206047375, 6212.254529456494, 6225.221847269091, 6226.128342032029, 6230.127782110599, 6078.939210607838, 6101.420365065312, 6107.083937409247, 6167.814965551041, 6178.042403427476, 6274.121622972879, 6286.465650419583, 6288.27684816252, 6293.905591416224, 6295.716692748746, 5937.554683398676, 6144.109104179958, 6146.262448506208, 6153.969230153821, 6156.815295541141], "unit": "score", "name": "prototype.html", "value": 4707.700358955051}, {"lowerIsBetter": false, "replicates": [768.0322793280465, 791.0586402181403, 800.7117437722419, 821.7509385733684, 853.965841366345, 13444.7311053779, 13587.252701101435, 13605.72788544231, 13633.318334083306, 13650.0, 12718.93640531796, 12778.55275065373, 12788.104832661717, 12792.104552681316, 12837.037222208348, 658.6509150150428, 661.2527843536797, 776.8912352270687, 791.79809148667, 793.2701914238885, 794.1700922535964, 794.1819925476768, 801.2268161224417, 802.7952872017627, 803.2048272210528, 830.3523251863556, 831.3017065664841, 831.4387788242942, 833.2251006563893, 838.4298676899706, 680.3876511139989, 681.492288245258, 829.2453866981078, 831.5883637599396, 839.0560619303284, 605.857623458487, 614.9108379285024, 618.9938100618981, 621.2638023941598, 622.6637615687523, 12812.61562153137, 12909.096363254575, 12930.54743083997, 12943.22340659554, 13022.544210952572, 12953.352332383438, 13099.47602095915, 13139.0, 13266.602001939957, 13391.933040334736, 9859.211263098934, 10006.299559030871, 10028.197744180448, 10158.796824063478, 10270.229732770073, 3510.4032314506594, 3545.3263879862743, 3548.432250839879, 3580.158662714286, 3693.1505753676806, 46016.53983460156, 46259.53740462586, 46282.53717462816, 46371.30443043357, 46393.76803115997, 10053.547590358452, 10301.484925753683, 10371.740706482247, 10456.52945617449, 10558.894411055944, 18434.26262949467, 18434.723479147822, 18446.538836528925, 18498.16758245882, 18548.072596370126, 6789.355011273921, 7058.153021637437, 7089.0, 7136.107986501687, 7160.749373771893, 4051.8379264829077, 4076.8369265229057, 4082.9795851020554, 4105.261053010427, 4129.587041295907, 2855.5002874497295, 2861.084452975028, 2863.5418333067028, 2870.3111253299476, 2883.423315336941, 515.9974200128976, 531.8085489223877, 539.0055347883149, 540.8404520666413, 543.1716632136024, 552.2516989479278, 615.2002396884033, 646.4505170605042, 646.5086534233922, 650.2099948562519, 8105.594720263964, 8248.711295104642, 8266.462679925786, 8337.749867503984, 8445.324374050062, 466.5987250964168, 496.39439883342266, 497.01094821305344, 502.24913753938097, 502.3921055522785, 3716.7769933804057, 3814.1990182062077, 3830.9233815324096, 3867.3812190049457, 4068.06434520062, 56364.0, 60371.0, 62776.37223627705, 63355.366446335865, 63379.0, 46556.301655475196, 46983.53016469791, 48352.27471587929, 50992.0, 51288.487115129115, 44501.55498445039, 44903.326450103275, 45616.31575526436, 46931.29603055957, 47061.0, 8769.868451973098, 8908.910910891067, 9148.862767058632, 9171.886217908937, 9226.677066302647, 31724.841375792974, 32337.0, 32797.67202327946, 33011.504827428085, 33124.1718957028, 40641.796791015855, 40763.59236407598, 41551.42934277167, 43331.35002974895, 44418.77790611156, 10589.576416943544, 10619.30974486656, 10668.253222274367, 11139.33164010162, 11294.265872718248, 12185.817212741993, 12277.69305767363, 12501.0, 12839.0, 13065.0, 11578.76842463163, 11584.94207528957, 11718.0, 11992.340421276913, 12144.271343719052, 11068.723281918017, 11108.346685509134, 11269.0, 11269.380184089627, 11288.830667540158, 11207.775844483227, 11343.149263805082, 11354.943225283821, 11495.94252028768, 11712.355820429959, 9766.804663906823, 9862.85205721929, 9876.35803672759, 10012.64955726546, 10166.085052345325, 9537.33238673314, 9891.653792117242, 9937.751556211153, 10092.49958772456, 10102.646407375707], "unit": "score", "name": "yui.html", "value": 6161.215481455859}], "name": "dromaeo_css", "value": 6786.2221621057415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 112.0, 109.0, 113.0, 111.0, 110.0, 104.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [149.0, 130.0, 153.0, 167.0, 125.0, 158.0, 161.0, 128.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 160.0, 160.0, 160.0, 163.0, 161.0, 159.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 98.0, 94.0, 72.0, 72.0, 73.0, 115.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.6}, {"lowerIsBetter": true, "replicates": [104.0, 96.0, 150.0, 96.0, 96.0, 95.0, 141.0, 95.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 148.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 54.0, 55.0, 54.0, 55.0, 56.0, 55.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 86.0, 86.0, 82.0, 82.0, 83.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [118.0, 116.0, 116.0, 112.0, 121.0, 123.0, 116.0, 113.0, 118.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 153.0, 145.0, 143.0, 132.0, 144.0, 141.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 68.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1494.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1114.6993318485524], "unit": "score", "name": "RayTrace", "value": 663.8462757242756}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [42125.0], "unit": "score", "name": "RegExp", "value": 21.625756676557863}, {"lowerIsBetter": false, "replicates": [611.2469437652812], "unit": "score", "name": "Splay", "value": 133.31927600000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19931.956999939717}]} 11:10:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19931.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6786.22"}}} 11:10:13 INFO - Return code: 0 11:10:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:10:13 INFO - # TBPL SUCCESS # 11:10:13 INFO - Running post-action listener: _resource_record_post_action 11:10:13 INFO - Running post-run listener: _resource_record_post_run 11:10:14 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 538345472; Read time: 0; Write time: 411988 11:10:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236355584; Read time: 0; Write time: 220976 11:10:14 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 301989888; Read time: 0; Write time: 191012 11:10:14 INFO - Running post-run listener: _upload_blobber_files 11:10:14 INFO - Blob upload gear active. 11:10:14 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:10:14 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 11:10:14 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'] 11:10:14 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 11:10:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:10:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:15 INFO - (blobuploader) - INFO - Done attempting. 11:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:16 INFO - (blobuploader) - INFO - Done attempting. 11:10:16 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:16 INFO - Return code: 0 11:10:16 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:10:16 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68ff0dd43a3e7a0c1ce3645157450c85a13ebab9683bd1155a5c0394c2fa0bc3af5ee08a4a8fa169d00fd23f18e22cee3caf7f0b7eaa0fb5480d4766984e63e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10e729c2434c2f31f8dc33437b50ceb68486ed246319f0e54686003b89851f8ac5aceff4f5b758dd83010fad876b29890084edee04326c9900da9c2341fdfadb"} 11:10:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:10:16 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:10:16 INFO - Contents: 11:10:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68ff0dd43a3e7a0c1ce3645157450c85a13ebab9683bd1155a5c0394c2fa0bc3af5ee08a4a8fa169d00fd23f18e22cee3caf7f0b7eaa0fb5480d4766984e63e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10e729c2434c2f31f8dc33437b50ceb68486ed246319f0e54686003b89851f8ac5aceff4f5b758dd83010fad876b29890084edee04326c9900da9c2341fdfadb"} 11:10:16 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:16 INFO - Copying logs to upload dir... 11:10:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 11:10:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.188470 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-22 11:10:16.655853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 11:10:16.659221) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68ff0dd43a3e7a0c1ce3645157450c85a13ebab9683bd1155a5c0394c2fa0bc3af5ee08a4a8fa169d00fd23f18e22cee3caf7f0b7eaa0fb5480d4766984e63e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10e729c2434c2f31f8dc33437b50ceb68486ed246319f0e54686003b89851f8ac5aceff4f5b758dd83010fad876b29890084edee04326c9900da9c2341fdfadb"} build_url:https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011486 build_url: 'https://queue.taskcluster.net/v1/task/IrGgiU4cRCCLU69EOp4OAQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68ff0dd43a3e7a0c1ce3645157450c85a13ebab9683bd1155a5c0394c2fa0bc3af5ee08a4a8fa169d00fd23f18e22cee3caf7f0b7eaa0fb5480d4766984e63e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10e729c2434c2f31f8dc33437b50ceb68486ed246319f0e54686003b89851f8ac5aceff4f5b758dd83010fad876b29890084edee04326c9900da9c2341fdfadb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-22 11:10:16.689091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 11:10:16.689449) ========= 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=32c5991c409366f7fec8a718000001d2-1453488549.714611-543558703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 11:10:16.771025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 11:10:16.771379) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 11:10:16.771740) ========= ========= Total master_lag: 0.28 =========