builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1452463344.61 results: success (0) buildid: 20160110113006 builduid: 560f6f622d0246da9ef5c05f2004ffca revision: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.614674) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.615160) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.615492) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006466 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.666513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.666961) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.741246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.741534) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004649 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.803210) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.803583) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.804013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.804324) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 14:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.1M=0s 2016-01-10 14:02:26 (30.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.999418) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:24.999744) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017748 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.050766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:25.051191) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c --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 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c --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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 14:02:26,456 truncating revision to first 12 chars 2016-01-10 14:02:26,456 Setting DEBUG logging. 2016-01-10 14:02:26,456 attempt 1/10 2016-01-10 14:02:26,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/993fd6b313af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 14:02:27,135 unpacking tar archive at: fx-team-993fd6b313af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.959007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:26.024288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:26.024639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:26.035914) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:26.036276) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 14:02:26.036758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-10 14:02:26.037086) ========= /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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:27 INFO - MultiFileLogger online at 20160110 14:02:27 in /builds/slave/test-pgo 14:02:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:02:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:02:27 INFO - {'append_to_log': False, 14:02:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:02:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:02:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:02:27 INFO - 'branch': 'Fx-Team', 14:02:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:27 INFO - 'config_files': ('talos/linux_config.py',), 14:02:27 INFO - 'default_actions': ('clobber', 14:02:27 INFO - 'read-buildbot-config', 14:02:27 INFO - 'download-and-extract', 14:02:27 INFO - 'populate-webroot', 14:02:27 INFO - 'create-virtualenv', 14:02:27 INFO - 'install', 14:02:27 INFO - 'run-tests'), 14:02:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:27 INFO - 'download_minidump_stackwalk': True, 14:02:27 INFO - 'download_symbols': 'ondemand', 14:02:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:27 INFO - 'installer_path': 'installer.exe', 14:02:27 INFO - 'log_level': 'info', 14:02:27 INFO - 'log_name': 'talos', 14:02:27 INFO - 'log_to_console': True, 14:02:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:27 INFO - 'opt_config_files': (), 14:02:27 INFO - 'pip_index': False, 14:02:27 INFO - 'sps_profile': False, 14:02:27 INFO - 'sps_profile_interval': 0, 14:02:27 INFO - 'suite': 'dromaeojs', 14:02:27 INFO - 'system_bits': '32', 14:02:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:27 INFO - 'title': 'talos-linux64-ix-023', 14:02:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:27 INFO - 'use_talos_json': True, 14:02:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:02:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:27 INFO - 'work_dir': 'build'} 14:02:27 INFO - ##### 14:02:27 INFO - ##### Running clobber step. 14:02:27 INFO - ##### 14:02:27 INFO - Running pre-action listener: _resource_record_pre_action 14:02:27 INFO - Running main action method: clobber 14:02:27 INFO - rmtree: /builds/slave/test-pgo/build 14:02:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:02:28 INFO - Running post-action listener: _resource_record_post_action 14:02:28 INFO - ##### 14:02:28 INFO - ##### Running read-buildbot-config step. 14:02:28 INFO - ##### 14:02:28 INFO - Running pre-action listener: _resource_record_pre_action 14:02:28 INFO - Running main action method: read_buildbot_config 14:02:28 INFO - Using buildbot properties: 14:02:28 INFO - { 14:02:28 INFO - "project": "", 14:02:28 INFO - "product": "firefox", 14:02:28 INFO - "script_repo_revision": "production", 14:02:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:02:28 INFO - "repository": "", 14:02:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:02:28 INFO - "buildid": "20160110113006", 14:02:28 INFO - "pgo_build": "True", 14:02:28 INFO - "basedir": "/builds/slave/test-pgo", 14:02:28 INFO - "buildnumber": 888, 14:02:28 INFO - "slavename": "talos-linux64-ix-023", 14:02:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:02:28 INFO - "platform": "ubuntu64_hw", 14:02:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:02:28 INFO - "branch": "fx-team", 14:02:28 INFO - "repo_path": "integration/fx-team", 14:02:28 INFO - "revision": "993fd6b313af4b40f4c09f9ab8fa3ea60dac935c", 14:02:28 INFO - "stage_platform": "linux64-pgo", 14:02:28 INFO - "builduid": "560f6f622d0246da9ef5c05f2004ffca", 14:02:28 INFO - "slavebuilddir": "test" 14:02:28 INFO - } 14:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 14:02:28 INFO - Running post-action listener: _resource_record_post_action 14:02:28 INFO - ##### 14:02:28 INFO - ##### Running download-and-extract step. 14:02:28 INFO - ##### 14:02:28 INFO - Running pre-action listener: _resource_record_pre_action 14:02:28 INFO - Running main action method: download_and_extract 14:02:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:28 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json 14:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json 14:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:02:30 INFO - Downloaded 1302 bytes. 14:02:30 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:02:30 INFO - Using the following test package requirements: 14:02:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'jsshell-linux-x86_64.zip'], 14:02:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02: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')]} 14:02:30 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:34 INFO - Downloaded 24028339 bytes. 14:02:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:02:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:02:35 INFO - Return code: 0 14:02:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:35 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:02:39 INFO - Downloaded 24028339 bytes. 14:02:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:02:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 14:02:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:02:40 INFO - Return code: 0 14:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:40 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:02:43 INFO - Downloaded 11132285 bytes. 14:02:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:02:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:02:43 INFO - Return code: 0 14:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:43 INFO - https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:02:46 INFO - Downloaded 55917524 bytes. 14:02:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:46 INFO - mkdir: /builds/slave/test-pgo/properties 14:02:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:02:46 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:02:46 INFO - Contents: 14:02:46 INFO - build_url:https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 14:02:46 INFO - Running post-action listener: _resource_record_post_action 14:02:46 INFO - Running post-action listener: set_extra_try_arguments 14:02:46 INFO - ##### 14:02:46 INFO - ##### Running populate-webroot step. 14:02:46 INFO - ##### 14:02:46 INFO - Running pre-action listener: _resource_record_pre_action 14:02:46 INFO - Running main action method: populate_webroot 14:02:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:46 INFO - '--tppagecycles', 14:02:46 INFO - '7'], 14:02:46 INFO - 'tests': ['tsvgm']}}, 14:02:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:02:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'tests': ['damp', 'tps']}, 14:02:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['damp', 'tps']}, 14:02:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:02:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:46 INFO - 'other': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'other_l64': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'other_nol64': {'tests': ['a11yr', 14:02:46 INFO - 'ts_paint', 14:02:46 INFO - 'tpaint', 14:02:46 INFO - 'sessionrestore', 14:02:46 INFO - 'sessionrestore_no_auto_restore']}, 14:02:46 INFO - 'svgr': {'tests': ['tsvgx', 14:02:46 INFO - 'tsvgr_opacity', 14:02:46 INFO - 'tart', 14:02:46 INFO - 'tscrollx', 14:02:46 INFO - 'cart']}, 14:02:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['tsvgx', 14:02:46 INFO - 'tsvgr_opacity', 14:02:46 INFO - 'tart', 14:02:46 INFO - 'tscrollx', 14:02:46 INFO - 'cart']}, 14:02:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'tests': ['tp5o']}, 14:02:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'talos_options': ['--e10s'], 14:02:46 INFO - 'tests': ['tp5o']}, 14:02:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'talos_options': ['--xperf_path', 14:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:46 INFO - 'tests': ['tp5n']}, 14:02:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:46 INFO - 'talos_options': ['--e10s', 14:02:46 INFO - '--xperf_path', 14:02:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:46 INFO - 'tests': ['tp5n']}}, 14:02:46 INFO - 'talos.zip': {'path': '', 14:02:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:46 INFO - Running post-action listener: _resource_record_post_action 14:02:46 INFO - ##### 14:02:46 INFO - ##### Running create-virtualenv step. 14:02:46 INFO - ##### 14:02:46 INFO - Running pre-action listener: _resource_record_pre_action 14:02:46 INFO - Running main action method: create_virtualenv 14:02:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:02:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:02:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:02:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:46 INFO - Using real prefix '/usr' 14:02:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:02:46 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:48 INFO - Installing pip.................done. 14:02:48 INFO - Return code: 0 14:02:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:02:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:48 INFO - Using env: {'DISPLAY': ':0', 14:02:48 INFO - 'HOME': '/home/cltbld', 14:02:48 INFO - 'LANG': 'en_US.UTF-8', 14:02:48 INFO - 'LANGUAGE': 'en_US:en', 14:02:48 INFO - 'LOGNAME': 'cltbld', 14:02:48 INFO - 'MAIL': '/var/mail/cltbld', 14:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:48 INFO - 'MOZ_NO_REMOTE': '1', 14:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:48 INFO - 'NO_EM_RESTART': '1', 14:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:48 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:48 INFO - 'SHELL': '/bin/bash', 14:02:48 INFO - 'SHLVL': '1', 14:02:48 INFO - 'TERM': 'linux', 14:02:48 INFO - 'TMOUT': '86400', 14:02:48 INFO - 'USER': 'cltbld', 14:02:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:48 INFO - '_': '/tools/buildbot/bin/python'} 14:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:02:48 INFO - Cleaning up... 14:02:49 INFO - Return code: 0 14:02:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:02:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:02:49 INFO - Using env: {'DISPLAY': ':0', 14:02:49 INFO - 'HOME': '/home/cltbld', 14:02:49 INFO - 'LANG': 'en_US.UTF-8', 14:02:49 INFO - 'LANGUAGE': 'en_US:en', 14:02:49 INFO - 'LOGNAME': 'cltbld', 14:02:49 INFO - 'MAIL': '/var/mail/cltbld', 14:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:49 INFO - 'MOZ_NO_REMOTE': '1', 14:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:49 INFO - 'NO_EM_RESTART': '1', 14:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:49 INFO - 'SHELL': '/bin/bash', 14:02:49 INFO - 'SHLVL': '1', 14:02:49 INFO - 'TERM': 'linux', 14:02:49 INFO - 'TMOUT': '86400', 14:02:49 INFO - 'USER': 'cltbld', 14:02:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:49 INFO - '_': '/tools/buildbot/bin/python'} 14:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:49 INFO - Downloading/unpacking psutil>=0.7.1 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:02:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:02:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:51 INFO - Installing collected packages: psutil 14:02:51 INFO - Running setup.py install for psutil 14:02:51 INFO - building 'psutil._psutil_linux' extension 14:02:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:02:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:02:51 INFO - building 'psutil._psutil_posix' extension 14:02:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:02:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:02:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:51 INFO - Successfully installed psutil 14:02:51 INFO - Cleaning up... 14:02:51 INFO - Return code: 0 14:02:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:02:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:02:51 INFO - Using env: {'DISPLAY': ':0', 14:02:51 INFO - 'HOME': '/home/cltbld', 14:02:51 INFO - 'LANG': 'en_US.UTF-8', 14:02:51 INFO - 'LANGUAGE': 'en_US:en', 14:02:51 INFO - 'LOGNAME': 'cltbld', 14:02:51 INFO - 'MAIL': '/var/mail/cltbld', 14:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:51 INFO - 'MOZ_NO_REMOTE': '1', 14:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:51 INFO - 'NO_EM_RESTART': '1', 14:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:51 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:51 INFO - 'SHELL': '/bin/bash', 14:02:51 INFO - 'SHLVL': '1', 14:02:51 INFO - 'TERM': 'linux', 14:02:51 INFO - 'TMOUT': '86400', 14:02:51 INFO - 'USER': 'cltbld', 14:02:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:51 INFO - '_': '/tools/buildbot/bin/python'} 14:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:02:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:02:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:02:53 INFO - Installing collected packages: mozsystemmonitor 14:02:53 INFO - Running setup.py install for mozsystemmonitor 14:02:53 INFO - Successfully installed mozsystemmonitor 14:02:53 INFO - Cleaning up... 14:02:53 INFO - Return code: 0 14:02:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:02:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:02:53 INFO - Using env: {'DISPLAY': ':0', 14:02:53 INFO - 'HOME': '/home/cltbld', 14:02:53 INFO - 'LANG': 'en_US.UTF-8', 14:02:53 INFO - 'LANGUAGE': 'en_US:en', 14:02:53 INFO - 'LOGNAME': 'cltbld', 14:02:53 INFO - 'MAIL': '/var/mail/cltbld', 14:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:53 INFO - 'MOZ_NO_REMOTE': '1', 14:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:53 INFO - 'NO_EM_RESTART': '1', 14:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:53 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:53 INFO - 'SHELL': '/bin/bash', 14:02:53 INFO - 'SHLVL': '1', 14:02:53 INFO - 'TERM': 'linux', 14:02:53 INFO - 'TMOUT': '86400', 14:02:53 INFO - 'USER': 'cltbld', 14:02:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:53 INFO - '_': '/tools/buildbot/bin/python'} 14:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:02:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:02:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:02:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:56 INFO - Downloading docopt-0.6.1.tar.gz 14:02:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:02:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:56 INFO - Running setup.py install for blobuploader 14:02:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:02:56 INFO - Running setup.py install for requests 14:02:56 INFO - Running setup.py install for docopt 14:02:56 INFO - Successfully installed blobuploader requests docopt 14:02:56 INFO - Cleaning up... 14:02:56 INFO - Return code: 0 14:02:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:02:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:02:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:56 INFO - Using env: {'DISPLAY': ':0', 14:02:56 INFO - 'HOME': '/home/cltbld', 14:02:56 INFO - 'LANG': 'en_US.UTF-8', 14:02:56 INFO - 'LANGUAGE': 'en_US:en', 14:02:56 INFO - 'LOGNAME': 'cltbld', 14:02:56 INFO - 'MAIL': '/var/mail/cltbld', 14:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:56 INFO - 'MOZ_NO_REMOTE': '1', 14:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:56 INFO - 'NO_EM_RESTART': '1', 14:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:02:56 INFO - 'PWD': '/builds/slave/test-pgo', 14:02:56 INFO - 'SHELL': '/bin/bash', 14:02:56 INFO - 'SHLVL': '1', 14:02:56 INFO - 'TERM': 'linux', 14:02:56 INFO - 'TMOUT': '86400', 14:02:56 INFO - 'USER': 'cltbld', 14:02:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:56 INFO - '_': '/tools/buildbot/bin/python'} 14:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:02:57 INFO - Running setup.py (path:/tmp/pip-pfpqFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:02:57 INFO - Running setup.py (path:/tmp/pip-3CgOlp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:02:57 INFO - Running setup.py (path:/tmp/pip-H5tBU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:02:57 INFO - Running setup.py (path:/tmp/pip-BxUBwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:02:57 INFO - Running setup.py (path:/tmp/pip-fJsrE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:02:57 INFO - Running setup.py (path:/tmp/pip-9ZvtCk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:02:57 INFO - Running setup.py (path:/tmp/pip-7d6I2T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:02:57 INFO - Running setup.py (path:/tmp/pip-WraGvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:02:57 INFO - Running setup.py (path:/tmp/pip-2GlJAG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:02:57 INFO - Running setup.py (path:/tmp/pip-Roxphl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:02:57 INFO - Running setup.py (path:/tmp/pip-s9GvN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:02:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:02:57 INFO - Running setup.py (path:/tmp/pip-2iPfAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:02:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:02:58 INFO - Running setup.py (path:/tmp/pip-vtRolf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:02:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:02:58 INFO - Running setup.py (path:/tmp/pip-NTCori-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:02:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:02:58 INFO - Running setup.py (path:/tmp/pip-izwSLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:02:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:02:58 INFO - Running setup.py (path:/tmp/pip-n7q__Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:02:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:02:58 INFO - Running setup.py (path:/tmp/pip-P0ADfa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:02:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:58 INFO - Running setup.py install for manifestparser 14:02:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:02:58 INFO - Running setup.py install for mozcrash 14:02:58 INFO - Running setup.py install for mozdebug 14:02:58 INFO - Running setup.py install for mozdevice 14:02:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:02:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:02:58 INFO - Running setup.py install for mozfile 14:02:58 INFO - Running setup.py install for mozhttpd 14:02:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozinfo 14:02:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozInstall 14:02:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozleak 14:02:59 INFO - Running setup.py install for mozlog 14:02:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for moznetwork 14:02:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozprocess 14:02:59 INFO - Running setup.py install for mozprofile 14:02:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozrunner 14:02:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:02:59 INFO - Running setup.py install for mozscreenshot 14:02:59 INFO - Running setup.py install for moztest 14:03:00 INFO - Running setup.py install for mozversion 14:03:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:03:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:03:00 INFO - Cleaning up... 14:03:00 INFO - Return code: 0 14:03:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:03:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:00 INFO - Using env: {'DISPLAY': ':0', 14:03:00 INFO - 'HOME': '/home/cltbld', 14:03:00 INFO - 'LANG': 'en_US.UTF-8', 14:03:00 INFO - 'LANGUAGE': 'en_US:en', 14:03:00 INFO - 'LOGNAME': 'cltbld', 14:03:00 INFO - 'MAIL': '/var/mail/cltbld', 14:03:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:00 INFO - 'MOZ_NO_REMOTE': '1', 14:03:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:00 INFO - 'NO_EM_RESTART': '1', 14:03:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:00 INFO - 'SHELL': '/bin/bash', 14:03:00 INFO - 'SHLVL': '1', 14:03:00 INFO - 'TERM': 'linux', 14:03:00 INFO - 'TMOUT': '86400', 14:03:00 INFO - 'USER': 'cltbld', 14:03:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:03:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:00 INFO - '_': '/tools/buildbot/bin/python'} 14:03:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:00 INFO - Running setup.py (path:/tmp/pip-3iqHPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:00 INFO - Running setup.py (path:/tmp/pip-CL3nJ3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:00 INFO - Running setup.py (path:/tmp/pip-Sm1V_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:00 INFO - Running setup.py (path:/tmp/pip-7uO35B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:00 INFO - Running setup.py (path:/tmp/pip-yjfNu6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:00 INFO - Running setup.py (path:/tmp/pip-qF8ZV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:00 INFO - Running setup.py (path:/tmp/pip-j0nZ7j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:00 INFO - Running setup.py (path:/tmp/pip-044rwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:03:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:00 INFO - Running setup.py (path:/tmp/pip-JEEf60-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:01 INFO - Running setup.py (path:/tmp/pip-SXXSNf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:01 INFO - Running setup.py (path:/tmp/pip-PJdWNn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:01 INFO - Running setup.py (path:/tmp/pip-MiwpU1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:01 INFO - Running setup.py (path:/tmp/pip-yforTO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:01 INFO - Running setup.py (path:/tmp/pip-MDCA3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:01 INFO - Running setup.py (path:/tmp/pip-Iigorr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:01 INFO - Running setup.py (path:/tmp/pip-k2Hrc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:03:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:01 INFO - Running setup.py (path:/tmp/pip-wPilO7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:03:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:03 INFO - Downloading blessings-1.5.1.tar.gz 14:03:03 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:03:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:03:03 INFO - Installing collected packages: blessings 14:03:03 INFO - Running setup.py install for blessings 14:03:03 INFO - Successfully installed blessings 14:03:03 INFO - Cleaning up... 14:03:03 INFO - Return code: 0 14:03:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:03:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:03 INFO - Reading from file tmpfile_stdout 14:03:03 INFO - Current package versions: 14:03:03 INFO - argparse == 1.2.1 14:03:03 INFO - blessings == 1.5.1 14:03:03 INFO - blobuploader == 1.2.4 14:03:03 INFO - docopt == 0.6.1 14:03:03 INFO - manifestparser == 1.1 14:03:03 INFO - mozInstall == 1.12 14:03:03 INFO - mozcrash == 0.16 14:03:03 INFO - mozdebug == 0.1 14:03:03 INFO - mozdevice == 0.47 14:03:03 INFO - mozfile == 1.2 14:03:03 INFO - mozhttpd == 0.7 14:03:03 INFO - mozinfo == 0.9 14:03:03 INFO - mozleak == 0.1 14:03:03 INFO - mozlog == 3.1 14:03:03 INFO - moznetwork == 0.27 14:03:03 INFO - mozprocess == 0.22 14:03:03 INFO - mozprofile == 0.28 14:03:03 INFO - mozrunner == 6.11 14:03:03 INFO - mozscreenshot == 0.1 14:03:03 INFO - mozsystemmonitor == 0.0 14:03:03 INFO - moztest == 0.7 14:03:03 INFO - mozversion == 1.4 14:03:03 INFO - psutil == 3.1.1 14:03:03 INFO - requests == 1.2.3 14:03:03 INFO - wsgiref == 0.1.2 14:03:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:03:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:03:03 INFO - Using env: {'DISPLAY': ':0', 14:03:03 INFO - 'HOME': '/home/cltbld', 14:03:03 INFO - 'LANG': 'en_US.UTF-8', 14:03:03 INFO - 'LANGUAGE': 'en_US:en', 14:03:03 INFO - 'LOGNAME': 'cltbld', 14:03:03 INFO - 'MAIL': '/var/mail/cltbld', 14:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:03 INFO - 'MOZ_NO_REMOTE': '1', 14:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:03 INFO - 'NO_EM_RESTART': '1', 14:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:03 INFO - 'SHELL': '/bin/bash', 14:03:03 INFO - 'SHLVL': '1', 14:03:03 INFO - 'TERM': 'linux', 14:03:03 INFO - 'TMOUT': '86400', 14:03:03 INFO - 'USER': 'cltbld', 14:03:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:03 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:03:04 INFO - Cleaning up... 14:03:04 INFO - Return code: 0 14:03:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 14:03:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:03:04 INFO - Using env: {'DISPLAY': ':0', 14:03:04 INFO - 'HOME': '/home/cltbld', 14:03:04 INFO - 'LANG': 'en_US.UTF-8', 14:03:04 INFO - 'LANGUAGE': 'en_US:en', 14:03:04 INFO - 'LOGNAME': 'cltbld', 14:03:04 INFO - 'MAIL': '/var/mail/cltbld', 14:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:04 INFO - 'MOZ_NO_REMOTE': '1', 14:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:04 INFO - 'NO_EM_RESTART': '1', 14:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:04 INFO - 'SHELL': '/bin/bash', 14:03:04 INFO - 'SHLVL': '1', 14:03:04 INFO - 'TERM': 'linux', 14:03:04 INFO - 'TMOUT': '86400', 14:03:04 INFO - 'USER': 'cltbld', 14:03:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:04 INFO - '_': '/tools/buildbot/bin/python'} 14:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:04 INFO - Downloading/unpacking jsonschema 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:03:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 14:03:05 INFO - Downloading/unpacking functools32 (from jsonschema) 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - Downloading functools32-3.2.3-2.tar.gz 14:03:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:03:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:03:06 INFO - warning: no files found matching '*.txt' 14:03:06 INFO - no previously-included directories found matching 'build' 14:03:06 INFO - no previously-included directories found matching 'dist' 14:03:06 INFO - no previously-included directories found matching '.git*' 14:03:06 INFO - Installing collected packages: jsonschema, functools32 14:03:06 INFO - Running setup.py install for functools32 14:03:06 INFO - warning: no files found matching '*.txt' 14:03:06 INFO - no previously-included directories found matching 'build' 14:03:06 INFO - no previously-included directories found matching 'dist' 14:03:06 INFO - no previously-included directories found matching '.git*' 14:03:06 INFO - Successfully installed jsonschema functools32 14:03:06 INFO - Cleaning up... 14:03:06 INFO - Return code: 0 14:03:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f064a989f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c0630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, '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': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:03:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 14:03:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:03:06 INFO - Using env: {'DISPLAY': ':0', 14:03:06 INFO - 'HOME': '/home/cltbld', 14:03:06 INFO - 'LANG': 'en_US.UTF-8', 14:03:06 INFO - 'LANGUAGE': 'en_US:en', 14:03:06 INFO - 'LOGNAME': 'cltbld', 14:03:06 INFO - 'MAIL': '/var/mail/cltbld', 14:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:06 INFO - 'MOZ_NO_REMOTE': '1', 14:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:06 INFO - 'NO_EM_RESTART': '1', 14:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:06 INFO - 'SHELL': '/bin/bash', 14:03:06 INFO - 'SHLVL': '1', 14:03:06 INFO - 'TERM': 'linux', 14:03:06 INFO - 'TMOUT': '86400', 14:03:06 INFO - 'USER': 'cltbld', 14:03:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:06 INFO - '_': '/tools/buildbot/bin/python'} 14:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:03:06 INFO - Downloading/unpacking flake8 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 14:03:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 14:03:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 14:03:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:03:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:09 INFO - no previously-included directories found matching 'docs/_build' 14:03:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:03:09 INFO - Running setup.py install for pep8 14:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:03:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:03:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:03:09 INFO - no previously-included directories found matching 'docs/_build' 14:03:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:03:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:03:09 INFO - Cleaning up... 14:03:09 INFO - Return code: 0 14:03:09 INFO - Running post-action listener: _resource_record_post_action 14:03:09 INFO - Running post-action listener: _start_resource_monitoring 14:03:09 INFO - Starting resource monitoring. 14:03:09 INFO - ##### 14:03:09 INFO - ##### Running install step. 14:03:09 INFO - ##### 14:03:09 INFO - Running pre-action listener: _resource_record_pre_action 14:03:09 INFO - Running main action method: install 14:03:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:03:09 INFO - Reading from file tmpfile_stdout 14:03:09 INFO - Detecting whether we're running mozinstall >=1.0... 14:03:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:03:09 INFO - Reading from file tmpfile_stdout 14:03:09 INFO - Output received: 14:03:09 INFO - Usage: mozinstall [options] installer 14:03:09 INFO - Options: 14:03:09 INFO - -h, --help show this help message and exit 14:03:09 INFO - -d DEST, --destination=DEST 14:03:09 INFO - Directory to install application into. [default: 14:03:09 INFO - "/builds/slave/test-pgo"] 14:03:09 INFO - --app=APP Application being installed. [default: firefox] 14:03:09 INFO - mkdir: /builds/slave/test-pgo/build/application 14:03:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:03:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:03:25 INFO - Reading from file tmpfile_stdout 14:03:25 INFO - Output received: 14:03:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:03:25 INFO - Running post-action listener: _resource_record_post_action 14:03:25 INFO - ##### 14:03:25 INFO - ##### Running run-tests step. 14:03:25 INFO - ##### 14:03:25 INFO - Running pre-action listener: _resource_record_pre_action 14:03:25 INFO - Running main action method: run_tests 14:03:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:03:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:03:25 INFO - Python 2.7.3 14:03:25 INFO - Return code: 0 14:03:25 INFO - grabbing minidump binary from tooltool 14:03: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')]} 14:03:25 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 0x1251840>, '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 0x11be6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11beb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:03:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:03:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:03:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:03:25 INFO - Return code: 0 14:03:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:03:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:03:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:03:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:03:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:03:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:03:26 INFO - Return code: 0 14:03:26 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 14:03:26 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 14:03:26 INFO - Using env: {'DISPLAY': ':0', 14:03:26 INFO - 'HOME': '/home/cltbld', 14:03:26 INFO - 'LANG': 'en_US.UTF-8', 14:03:26 INFO - 'LANGUAGE': 'en_US:en', 14:03:26 INFO - 'LOGNAME': 'cltbld', 14:03:26 INFO - 'MAIL': '/var/mail/cltbld', 14:03:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:03:26 INFO - 'MOZ_NO_REMOTE': '1', 14:03:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:03:26 INFO - 'NO_EM_RESTART': '1', 14:03:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:03:26 INFO - 'PWD': '/builds/slave/test-pgo', 14:03:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:03:26 INFO - 'SHELL': '/bin/bash', 14:03:26 INFO - 'SHLVL': '1', 14:03:26 INFO - 'TERM': 'linux', 14:03:26 INFO - 'TMOUT': '86400', 14:03:26 INFO - 'USER': 'cltbld', 14:03:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644', 14:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:03:26 INFO - '_': '/tools/buildbot/bin/python'} 14:03:26 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/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 14:03:26 INFO - mozversion application_buildid: 20160110113006 14:03:26 INFO - mozversion application_changeset: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c 14:03:26 INFO - mozversion application_display_name: Nightly 14:03:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:03:26 INFO - mozversion application_name: Firefox 14:03:26 INFO - mozversion application_remotingname: firefox 14:03:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:03:26 INFO - mozversion application_vendor: Mozilla 14:03:26 INFO - mozversion application_version: 46.0a1 14:03:26 INFO - mozversion platform_buildid: 20160110113006 14:03:26 INFO - mozversion platform_changeset: 993fd6b313af4b40f4c09f9ab8fa3ea60dac935c 14:03:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:03:26 INFO - mozversion platform_version: 46.0a1 14:03:26 INFO - using testdate: 1452463406 14:03:26 INFO - actual date: 1452463406 14:03:26 INFO - starting webserver on 'localhost:57685' 14:03:26 INFO - SUITE-START | Running 3 tests 14:03:26 INFO - TEST-START | dromaeo_css 14:03:26 INFO - operating with platform_type : linux_ 14:03:26 INFO - Initialising browser for dromaeo_css test... 14:03:27 INFO - TEST-INFO | started process 27661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn7gXBI/profile http://localhost:57685/getInfo.html) 14:03:30 INFO - PROCESS | 27661 | __metrics Screen width/height:1600/1200 14:03:30 INFO - PROCESS | 27661 | colorDepth:24 14:03:30 INFO - PROCESS | 27661 | Browser inner width/height: 1024/697 14:03:30 INFO - PROCESS | 27661 | __metrics 14:03:30 INFO - PROCESS | 27661 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:03:30 INFO - PROCESS | 27661 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:03:31 INFO - TEST-INFO | 27661: exit 0 14:03:31 INFO - Browser initialized. 14:03:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:03:31 INFO - TEST-INFO | started process 27759 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpn7gXBI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:43 INFO - PROCESS | 27759 | RSS: Main: 148672512 14:03:43 INFO - PROCESS | 27759 | 14:04:35 INFO - PROCESS | 27759 | 1452463475285 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:06:43 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57685/tests/dromaeo/cssquery-ext.html) 14:06:44 INFO - PROCESS | 27759 | RSS: Main: 281448448 14:06:44 INFO - PROCESS | 27759 | 14:09:47 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-ext.html (next: http://localhost:57685/tests/dromaeo/cssquery-jquery.html) 14:09:47 INFO - PROCESS | 27759 | RSS: Main: 237629440 14:09:47 INFO - PROCESS | 27759 | 14:12:49 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57685/tests/dromaeo/cssquery-mootools.html) 14:12:50 INFO - PROCESS | 27759 | RSS: Main: 233848832 14:12:50 INFO - PROCESS | 27759 | 14:15:52 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57685/tests/dromaeo/cssquery-prototype.html) 14:15:52 INFO - PROCESS | 27759 | RSS: Main: 215056384 14:15:52 INFO - PROCESS | 27759 | 14:18:55 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57685/tests/dromaeo/cssquery-yui.html) 14:18:55 INFO - PROCESS | 27759 | RSS: Main: 221626368 14:18:55 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | Cycle 1(1): loaded http://localhost:57685/tests/dromaeo/cssquery-yui.html (next: http://localhost:57685/tests/dromaeo/cssquery-dojo.html) 14:21:58 INFO - PROCESS | 27759 | RSS: Main: 310607872 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | __start_tp_report 14:21:58 INFO - PROCESS | 27759 | _x_x_mozilla_page_load 14:21:58 INFO - PROCESS | 27759 | _x_x_mozilla_page_load_details 14:21:58 INFO - PROCESS | 27759 | |i|pagename|runs| 14:21:58 INFO - PROCESS | 27759 | |0;dojo.html;3042.345895632439;3086.2438702517857;3131.6398614159366;3149.7637677174203;3177.698118678725;4939.678920870141;5037.748112594374;5082.974585127074;5113.667611605243;5146.5110814472655;5031.1698569736045;5062.974685126578;5122.436531981479;5129.358830146231;5191.974040129803;4644.6748727589165;4672.742999135046;4678.672492925497;4711.151992641323;4800.159972004903;4750.857474275777;4762.095201911626;4764.237721964487;4796.808127674889;4810.87972800681;4591.632669386441;4601.700889442209;4674.368960190365;4685.016146609216;4703.952960470403;4662.836800711959;4692.671512994092;4704.364910737041;4705.858824235278;4724.480307166209;4632.698874573176;4657.091867085919;4662.230731929261;4686.742229177394;4701.412323459567;4792.688475249098;4902.068606964701;4919.926201106986;4965.577925876305;5073.898522029575;5366.034113859504;5416.756245968941;5417.214503896913;5436.075867102562;5439.347278326626;5453.130344687405;5453.918191227135;5461.344638643388;5462.5083742462975;5497.092979658391;4995.650304478688;5041.269015992661;5122.692638441706;5153.716545589991;5164.690118592859;5573.191887176336;5576.7211639417865;5579.832605021856;5586.217929489874;5627.690477023803;5364.409914909357;5367.570594352443;5370.650907690988;5371.4628537146755;5372.785088596413;5318.042752304622;5433.239346491494;5459.645123066988;5460.563154947595;5582.162675598612;5449.4005659377435;5454.509094181542;5458.536024437888;5460.5085542300585;5461.399246082928;5393.271908292409;5439.374471935699;5445.237666726662;5447.319085114361;5480.342358916876;4223.303154979455;4281.892952676208;4303.698741088094;4344.218040752695;4382.802773875183;3823.1206822430995;3835.328817456934;3844.1927195288745;3871.5741268460447;3876.8255428505786;4993.251012348104;5104.948950510522;5115.769790359368;5119.436861945183;5165.302684137669;5462.071447853875;5472.589555783332;5504.366997795305;5522.30971128609;5561.555075593943;5056.57019153376;5109.38687357512;5119.564836988823;5124.180131178993;5161.690298582097;4614.538546145359;4689.460712018094;4698.7415692137265;4702.85891423251;4704.059188162313;5585.162225666182;5625.184348269478;5626.381098079208;5637.154426836008;5671.262735844314;5492.340919089735;5512.7519261634125;5512.834614961557;5515.779368825202;5524.33707955048;5535.972320138373;5642.492175704207;5691.459311365414;5710.2862142232225;5717.571182161271;5359.678419294699;5395.973020134874;5400.864978375572;5415.566754659539;5452.754626041917;5468.125099983983;5468.507834294933;5468.617196796186;5469.013888612838;5478.287822583198;5195.740212989411;5296.04671159195;5314.12316967696;5319.547838433622;5396.1905714143195;5372.704501252469;5398.676079435247;5402.918956215739;5405.081136206933;5411.540019098421;5291.100512912737;5311.973440132774;5317.654352467077;5324.227986941949;5363.27595774581;5238.109521381451;5267.552258058108;5280.128778751617;5334.866628334323;5390;5179.585633149414;5302.416734159162;5330.360356757214;5333.43998880112;5350.250964865 14:21:58 INFO - PROCESS | 27759 | |1;ext.html;531.5614617940198;559.0998492427193;560.2296841842467;569.9059655156897;584.3251045042975;28234.152975410718;28921.710782892165;28987.710122898763;28997.130086097426;29027.564586531218;36324.27351452976;36545.45181822268;36754.44868326977;36755;36797;8432.241098301152;8486.769418434324;8557.93025871766;8559.058503564604;8574.657013719443;7495.5127916685515;7683.346915512188;8286.5028098314;8428.072911979709;8428.452150610221;10012.249081318894;10193;10210.795784084314;10215.744606384826;10229.897701022968;9855.457949812757;9962.701118966443;9970.800583988352;9971.302008859382;9977.401355918668;7539.849203015964;7753.573553454557;9791.706248812547;9828.557714902847;10080.59677612902;36446.271074578624;36738.63261367379;36799.08002299937;36923.63076369229;36974.26051478982;3412.8805491807916;3733.663970242691;3785.9432108518117;3921.3725803871243;3938.113924367023;27902.302442438897;28062.298442538897;28521.286967825763;28601.856990714914;29638.259043523867;3419.9658003419895;3430.811305378203;3448.620651728308;3517.9120521986897;3590.2101537661674;303342;303984.4800776004;306784;307494;307766;54710.17934730982;55115.44884551183;55349.72325138348;55379.123461358125;55511.16733249005;55124.17313740297;55960.16059759026;64703.67648161729;65719.34280657228;65724.78440194976;14019.299035048207;14081.788773168411;14195.645108872155;14207.431702731776;14226.644333891736;10584.312019718695;10597.311174773615;10623;10625.681229563126;10629.787404252027;19164.71252931207;19464;19516.219351226075;19531.316403925794;19551.315703950295;7794.727184548514;7977.242161994717;8037.115917249098;8045.597720113971;8116.472429292077;946.4983558713893;952.3857112162755;1028.5063169678597;1066.664000839733;1072.5495291977231;27863.442731145667;28446;30597;32213.194670132965;32942.50586241209;1016.1159790981893;1048.8374301983206;1058.5501162006117;1070.5824728355947;1100.983485247722;13787.310634468236;13842.515511957034;14139.64650883736;14158.663820469714;14258.643533911527;453055;463739;463841;463930;464287;50981.49018509842;51676;51782.22326665103;51963.22055169175;51992.74003630033;1359.0554564577722;1366.187118664393;1367.405178747248;1375.6010756880391;1377.6486995816003;23037.539249215257;28153;29844.253893651963;30230.54654180145;30241.243968900075;44493.77753111214;45245.77377113225;45294.32058519059;45382.31926521039;45489.77255113703;224307;225194;225835;226465;226666;27425.45149096967;27745.861270693516;30126.397472049997;31261.687383126788;31886.811318867927;36290.63709362978;37292.627073728916;37398;37638.81180594079;37824.62175378321;31535.75908407218;31871.68128318687;32164.839175803972;33016.50475242825;34655;34173;34278.14304642404;34297.31405371929;34421.16759332764;35125;33240.83379583087;34107.48838767371;34203.315933680686;34285.48571771375;34328.48507272443;28941.276468088465;31190.376192476477;31391.68608313979;31854.522182166824;31866.203344915633;23797.643035354136;24007.879960600087;24145.879270603535;24371.878140609184;24510.264692059267 14:21:58 INFO - PROCESS | 27759 | |2;jquery.html;348.1644054269754;349.8303322888399;355.2132027558957;357.0965457392797;358.21908240036726;13270.402831872565;13761.518346857836;15832.604184895383;15881.682366352681;16704.248308826103;15007.174605396725;15008.324625391857;16007.35970561179;16031.278592463337;16038.919805400958;4987.900241995158;5381.5425688816495;5395.352557693062;5399.406065332811;5400.756965936543;2988.5068963620975;3920.8627698030573;4074.7962601869935;5666.660000399968;5892.911606325887;5619.129034999562;5803.970980145094;5846.941530584703;5850.034744267191;5941.940580594182;5855.47300742933;5874.441928016874;5883.264591926009;5887.381824908387;5897.557683173779;4692.296155576657;4871.36672232611;4878.634102442331;4879.536444037811;5174.172132458826;11362.488688008976;11380.260283081574;11391.259568128045;11900.047996160287;12029;2016.1229865008768;2112.9788702112937;2113.260358874397;2257.954840903189;2446.8898899549386;8888.333374996837;8916.286697064219;9101.590428430736;9138.086191380875;9141.040190779939;1781.6347648731978;1799.2712951254762;1826.5707558723689;1847.2703282203588;1856.5004965639866;49723.508294750856;51133.23300150501;51216;52379;52840.471595284325;9528.761780955532;9584.952075239718;9626.518674066268;9630.422174669402;9701;12263.509459621693;12306.261624302571;12355.135140540076;12366.814497782541;12417.565385211474;6885.173779146434;7071.292870712888;7082.752103676346;7119.786406407816;7141.392981596518;6749.358810913053;6806.387425131663;6807;6827.829304267433;6860.0738900248825;3822.694184465236;4059.6752259819145;4083.714140010171;4120.443740095108;4268.9786551067045;1636.8526832584887;1640.7374820028977;1652.7686123942658;1663.9584010399838;1664.118017450753;414.41153561942116;415.1779476636217;429.63266407222;930.9255259579218;1000.1998401278947;9826.606935722633;10269.127124194378;10355.637552685619;10405.687829365132;10595;418.6483353982669;439.9032212913154;444.3024451611004;449.8133274691032;450.6710101625832;5565.443455654402;5789.768409263666;5821.166332605216;8831.779205519784;9438.103380178873;375004;383477;385084;502672;507007;57025.71487142538;62283.6885815568;62754;63011.369886301465;63982;1103.5971870267456;1125.454154734953;1140.0423644138798;1141.0928311991986;1142.6743378137357;14154.079984800956;14194.43222271139;14731.779023314444;15299.005564638263;15655.21723913777;21094.156233750477;31163.37673246477;31171.220719482193;31180;31474.05577832669;38163.61836381712;38754.61245387623;39983;40605;41185.79407103065;6815;7097.609631470319;7105.8578828422105;7110.608916509642;7188.317109874553;8817.735467935972;10404.68785936423;10784.838227426439;10870.45647717595;11251.381174035507;7563.470557060953;9691.951540242253;9823.21414286841;9935.304528683211;10129.898701012895;9786.902130978599;9829.950850245703;10029.539738932495;10275.897241027495;10278.948605256926;7346.044399496266;8843.51360675169;9840.40957542521;9984.151347135576;10255.58977640886;6841.623710695761;7099.07711997437;7129.108861392326;7188.424926005802;7307.196208416964;9161;9432.245420366491;9473.763155921157;9696.709098726767;9959.850602241117 14:21:58 INFO - PROCESS | 27759 | |3;mootools.html;1247.0647014738945;1400.3418393355123;1405.3184205660257;1520.2702702702702;1697.2107969794051;6357.173567436233;6818.829529261771;6969.546979446332;6992.195897471793;6996.720131194759;6741.359570840775;6964.5473044252085;6966.198887127982;6972.163340399146;6973.093497845286;1916.338863092238;1974.042589344167;2196.5936301784222;2226.8886555672193;2253.211376018389;2235.8993845277;2240.0367841828006;2245.8091062259728;2247.202243203664;2248.910043598254;2117.7776333484994;2120.957580848382;2122.289033173881;2128.31893793986;2135.1993002624017;2069.1619893942902;2074.087401543316;2092.5501017281204;2221.1004543160047;2224.7663995280423;2176.205684924991;2211.6793065005645;2227.8217742580555;2228.5097278598846;2228.855124416924;7192.208857025723;7230.060092188034;7238.059052323217;7240.4569657275915;7259.310365515267;4369.2353838078525;4463.04044630406;4473.329000649896;4476.910461790746;4480.238359478896;2920.6057182280333;2951.719586639266;2958.4970555005702;2971.643402791657;3101.720845123927;994.7065615643403;997.042838874674;1015.1675625986694;1035.249444152983;1047.7328281288299;9503.66737164196;9516.429014259167;9516.714498565123;9523.428594284296;9529.618815247382;4074.9796251019147;4103.5691252418665;4174.937375939363;4176.895577610584;4187.853425130106;8319.251267385964;8380.078191398941;8397.832043359098;8408.2432581068;8414.074451810297;4549.3176023596725;4589.036302376471;4590.908181836411;4591.517890621437;4596.632269418438;4179.832806687698;4182.769947652909;4188.4136220929095;4189.97905010473;4197.580241975839;3238.158078899503;3291.1772056985756;3423.3324501722423;3427.503012063287;3486.936484372291;1104.3539529375246;1154.1747650429984;1157.9594714185132;1158.1932185790195;1158.7798318319492;1172.472387425662;1255.6672481792332;1274.6622145131548;1285.3701686173708;1294.4433893425917;6692.96653516739;6746.291639377893;6769.39075483199;6787.185537735503;6803.183617965777;1094.4363652718855;1099.4777480696605;1104.812181929074;1104.828751543512;1121.041509509374;5325.281087053276;5391.865203369947;5397.541208997201;5403.2705584746345;5409.756560954766;8310.70912518059;8384.706535271236;8532.104129066483;8639.697610583726;8642.697505587274;8547.034182138019;8549.358798090168;8553.486790792573;8554.57227138653;8569.228769410784;6589.044588534635;6744.7976560703255;6746.291639377795;6829.965850170717;6833.521653484208;6476.352364763486;6536.084948107174;6538.4115429609665;6542.803715888531;6545.803625891231;7512.060992375953;7665.271799179069;7713.267239612228;7803.297703206738;7830.256125668053;7735;7775.727849525239;7898.091719452107;7999.200079991954;8006.519608823489;6404.263509696445;6461.418472337325;6463.741450341934;6464.676766161579;6473.1261279728515;6003.219581454383;6205.317415084247;6663.333666633298;6687;6705.865882682417;6446.4520515756685;6492.156019717407;6571.277159512545;6601.768938087144;6614.074029635759;6377.617342959437;6433;6490.870182596416;6511.2512061113575;6592.901106483502;6497.382748638872;6560.278369379269;6564.770233041821;6565.835854103495;6573.605583664996;6025.096235564701;6075.696215189311;6077.544184186116;6079.696015199311;6087.269527656709;5977.3126090500145;6088.6042407243385;6107.725152368065;6107.877842443215;6109.2974307955155 14:21:58 INFO - PROCESS | 27759 | |4;prototype.html;315.9162821852211;320.6809224821303;321.2899492122409;322.66765231811235;323.14205783644417;5822.65064096154;5851.7951871684445;5887.028640274355;5910.290765108182;5941.88116237675;5829.125631155329;5898.970505147479;5899.705014749256;5903.704814759266;5904.5866789324655;4309.698321117523;4385.605295523403;4401.383806267125;4487.865364039068;4490.281554951217;4458.108378324332;4460.063386688799;4489.7979590918485;4490.708103973231;4502.774861256924;4434.866953991385;4437.445319335083;4439.955600443986;4446.955530444687;4457.799399027035;4262.062346283828;4352.717073390236;4389.473263208403;4451.109778044404;4458.331250312447;3913.1977944521304;3917.2557214129224;3924.2151569686175;3932.5477570079233;3942.349512330462;5504.2018907258625;5541.390447050821;5559.388467268597;5559.861003474905;5571.637843540157;5202.401723801736;5210.895782084375;5214.270002199695;5216.061109000379;5222.321098257202;6105.725242364104;6121.877562448771;6162.815115546541;6164.568480206387;6170.043643235305;4390.319500477431;4390.363397307373;4394.428724265825;4396.20868243716;4396.824127034914;6385.5210859185745;6479.481641468671;6483.675816209124;6485.870282594322;6490.610563366213;4327.307630779061;4393.6704747144095;4399.978000110043;4409.559044095565;4469.642428605769;4512.81948722054;4513.571210734975;4515.458145022619;4518.864434066983;4520.547945205453;5170.069387510284;5179.818706345335;5183.844484665466;5188.792448302026;5190.455002224788;6264.060390941395;6272.1219029335925;6280.214973128359;6283.497320214372;6286.245650521967;1578.2424436270426;1594.3224129745045;1604.9567780942248;1612.5887898585786;1613.6772645470953;1053.5680371047833;1059.8887116852773;1065.8827528971806;1066.664000839733;1081.7836432713489;5929.703514824328;5940.34656187819;5946.137810017523;5947.613405128739;5950.315713692894;6307.369263073748;6349.079383489368;6363.395477429637;6429.935700643027;6442.645654488954;5859.941400586024;5879.853003674857;5883.941160588425;5920.911186332209;5932.614380065282;3246.123546642393;3357.3285342931513;3378.239896023375;3463.982680086634;3469.87855425064;6617.702203400859;6650.068990341356;6651.86696266072;6655.73377064912;6667.533272670964;6537.901931471032;6541.116949211891;6579.539432239697;6591.802245932629;6605.207375115017;6568.211814582281;6715.966420167965;6719.0593316935665;6726.831829204309;6735.528513004043;6468.8059358219325;6484.708188131451;6488.545801793829;6490.7079181436;6490.8052758417325;6362.491000720024;6384.042393640991;6388.201474815648;6390;6396.168498095218;6567.573107747981;6646.933530664632;6672.566283191577;6697.06241126233;6714.764983225564;4538.478075021415;4541.72749635023;4544.2274813281165;4545.477270113979;4546.1135078659345;6403.7118329676205;6457.128287681291;6468.902966455413;6469.547131700736;6470.579412338183;6143.938560614337;6298.779542715983;6308.211473565804;6310.148130002391;6320.209973753281;6291.465225455704;6293.150424692608;6294.527910406646;6302.117703521419;6302.747890084345;6183.876322473615;6190.473809726223;6192.256929168529;6193.752249910133;6194.287656919512;6175.289841668266;6320.747170113144;6322.494200464043;6340.048992651139;6346.492280617632;6166.167567378347;6175.5677102602385;6176.505879529716;6177.2587289525545;6181.474574661204 14:21:58 INFO - PROCESS | 27759 | |5;yui.html;722.4906440959123;743.1379599664388;768.7539987204095;776.9883451748221;789.5499565247808;13362.532311369092;13364.599062028143;13423.395947182376;13461.730765384686;13463.932680336584;12689.4924203032;12719.173253738523;12763;12824.807627885566;12848.421821018053;651.8565915498607;652.0284775684244;775.4455564271544;778.4006315137341;804.7666176808718;795.645937557787;796.5778137587088;800.2637573432427;803.2650125135523;803.2650125135523;832.7585000349891;835.9916400835974;836.9455985360962;837.7696133563257;838.2455789789177;687.6355531568277;691.5021184747;823.1233736071065;837.7905523619095;840.2437805974611;615.1203778596605;615.273976707485;615.3538784276492;615.6152404747033;615.9445649891486;12902.096853220279;12977.221366717933;12977.221366718028;12992.090553661248;13020.283884386356;12740.745185096339;12994.350282485839;13028;13235.470581176742;13261.46954121834;10185.59257629694;10214.438205898747;10248.538815753234;10835.83746243807;11074.501647425885;3608.0077978555846;3622.5471816022996;3632.2553876455263;3640.5085313482605;3756.286305601954;42181.789091054656;42259.36610950838;42323.788381058206;42469;43650.563494364964;9229.630814767468;9353;9476.384035037701;9517.762055948519;9595.90404095964;15863.762043569355;15886.76169857453;15970.281337339848;17206.225719842638;17488.562785930455;6933.7226510939;6956.930430695729;7180.1742799578715;7472.962635186789;7577.598144343314;4127.09203975125;4138.544760076389;4157.48031496063;4166.520850102216;4183.707140500136;2852.800303978702;2869.182283049321;2871.956920646192;2872.1096460097438;2887.7112288770954;499.74762744813637;512.8743457852776;517.9818706345335;532.4329588987794;532.9973350133303;559.1808001278147;600.3156401702063;610;645.3868824616633;657.8717150155769;9096.772580685536;9158.129977652112;9187.81624367509;9205.861912071325;9412.058794120534;648.2156590525517;674.1135406939858;674.4402146218627;685.1606781692387;695.2317688953734;3729.906752331159;3786;3872.3223435898603;3960.2277555876326;3987.7806720630642;51222;51847.48152518502;51856;52161.2175817363;52235.47764522382;47015.76492117518;48054.519454805704;48741.26888096681;48888.75555622199;49029.50970490249;41555.792221038704;41614.791926040176;42386;42557.787211064366;42644;7591.824496526999;7608.657610407656;7861.135275119618;7907.8813817793925;7953.9602301990435;33916.660833391354;34017.48973765346;34935.475967859995;35356.469652954715;36084.81957590195;40701.79649101854;40740.388894167205;41240;41319;41672.37491437692;10656.84014739795;10701.678949631523;11027.669169924915;11051;11451.484683189443;10962.56149754001;11409.543618255177;11500.424978750862;11541.942290288494;11629.53481860716;11314.15143864197;11706.70733231676;11774.823377649513;12015.639530814089;12075;11493.54025838957;11759.118066144902;11793.587224447103;11849.348285844362;12331.383430828244;11035.337879727242;11061.999880270807;11111.944440277746;11389.772204555697;11482.368469734245;9145.817083658156;9286.442813431217;9305.906940930505;9483.110699379557;9523.19052880513;9300.302477314093;9349.813003739751;9831.9016809831;10257.435841028517;10272.075513203847 14:21:58 INFO - PROCESS | 27759 | __end_tp_report 14:21:58 INFO - PROCESS | 27759 | __start_cc_report 14:21:58 INFO - PROCESS | 27759 | _x_x_mozilla_cycle_collect,1027 14:21:58 INFO - PROCESS | 27759 | __end_cc_report 14:21:58 INFO - PROCESS | 27759 | __startTimestamp1452464518719__endTimestamp 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | ------- Summary: start ------- 14:21:58 INFO - PROCESS | 27759 | Number of tests: 6 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#0] dojo.html Cycles:165 Average:5086.61 Median:5302.42 stddev:538.95 (10.2%) stddev-sans-first:516.19 14:21:58 INFO - PROCESS | 27759 | Values: 3042.3 3086.2 3131.6 3149.8 3177.7 4939.7 5037.7 5083.0 5113.7 5146.5 5031.2 5063.0 5122.4 5129.4 5192.0 4644.7 4672.7 4678.7 4711.2 4800.2 4750.9 4762.1 4764.2 4796.8 4810.9 4591.6 4601.7 4674.4 4685.0 4704.0 4662.8 4692.7 4704.4 4705.9 4724.5 4632.7 4657.1 4662.2 4686.7 4701.4 4792.7 4902.1 4919.9 4965.6 5073.9 5366.0 5416.8 5417.2 5436.1 5439.3 5453.1 5453.9 5461.3 5462.5 5497.1 4995.7 5041.3 5122.7 5153.7 5164.7 5573.2 5576.7 5579.8 5586.2 5627.7 5364.4 5367.6 5370.7 5371.5 5372.8 5318.0 5433.2 5459.6 5460.6 5582.2 5449.4 5454.5 5458.5 5460.5 5461.4 5393.3 5439.4 5445.2 5447.3 5480.3 4223.3 4281.9 4303.7 4344.2 4382.8 3823.1 3835.3 3844.2 3871.6 3876.8 4993.3 5104.9 5115.8 5119.4 5165.3 5462.1 5472.6 5504.4 5522.3 5561.6 5056.6 5109.4 5119.6 5124.2 5161.7 4614.5 4689.5 4698.7 4702.9 4704.1 5585.2 5625.2 5626.4 5637.2 5671.3 5492.3 5512.8 5512.8 5515.8 5524.3 5536.0 5642.5 5691.5 5710.3 5717.6 5359.7 5396.0 5400.9 5415.6 5452.8 5468.1 5468.5 5468.6 5469.0 5478.3 5195.7 5296.0 5314.1 5319.5 5396.2 5372.7 5398.7 5402.9 5405.1 5411.5 5291.1 5312.0 5317.7 5324.2 5363.3 5238.1 5267.6 5280.1 5334.9 5390.0 5179.6 5302.4 5330.4 5333.4 5350.3 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#1] ext.html Cycles:180 Average:48413.32 Median:18792.94 stddev:91489.03 (486.8%) stddev-sans-first:91675.05 14:21:58 INFO - PROCESS | 27759 | Values: 531.6 559.1 560.2 569.9 584.3 28234.2 28921.7 28987.7 28997.1 29027.6 36324.3 36545.5 36754.4 36755.0 36797.0 8432.2 8486.8 8557.9 8559.1 8574.7 7495.5 7683.3 8286.5 8428.1 8428.5 10012.2 10193.0 10210.8 10215.7 10229.9 9855.5 9962.7 9970.8 9971.3 9977.4 7539.8 7753.6 9791.7 9828.6 10080.6 36446.3 36738.6 36799.1 36923.6 36974.3 3412.9 3733.7 3785.9 3921.4 3938.1 27902.3 28062.3 28521.3 28601.9 29638.3 3420.0 3430.8 3448.6 3517.9 3590.2 303342.0 303984.5 306784.0 307494.0 307766.0 54710.2 55115.4 55349.7 55379.1 55511.2 55124.2 55960.2 64703.7 65719.3 65724.8 14019.3 14081.8 14195.6 14207.4 14226.6 10584.3 10597.3 10623.0 10625.7 10629.8 19164.7 19464.0 19516.2 19531.3 19551.3 7794.7 7977.2 8037.1 8045.6 8116.5 946.5 952.4 1028.5 1066.7 1072.5 27863.4 28446.0 30597.0 32213.2 32942.5 1016.1 1048.8 1058.6 1070.6 1101.0 13787.3 13842.5 14139.6 14158.7 14258.6 453055.0 463739.0 463841.0 463930.0 464287.0 50981.5 51676.0 51782.2 51963.2 51992.7 1359.1 1366.2 1367.4 1375.6 1377.6 23037.5 28153.0 29844.3 30230.5 30241.2 44493.8 45245.8 45294.3 45382.3 45489.8 224307.0 225194.0 225835.0 226465.0 226666.0 27425.5 27745.9 30126.4 31261.7 31886.8 36290.6 37292.6 37398.0 37638.8 37824.6 31535.8 31871.7 32164.8 33016.5 34655.0 34173.0 34278.1 34297.3 34421.2 35125.0 33240.8 34107.5 34203.3 34285.5 34328.5 28941.3 31190.4 31391.7 31854.5 31866.2 23797.6 24007.9 24145.9 24371.9 24510.3 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#2] jquery.html Cycles:180 Average:23161.82 Median:447.06 stddev:71087.95 (15901.3%) stddev-sans-first:71266.73 14:21:58 INFO - PROCESS | 27759 | Values: 348.2 349.8 355.2 357.1 358.2 13270.4 13761.5 15832.6 15881.7 16704.2 15007.2 15008.3 16007.4 16031.3 16038.9 4987.9 5381.5 5395.4 5399.4 5400.8 2988.5 3920.9 4074.8 5666.7 5892.9 5619.1 5804.0 5846.9 5850.0 5941.9 5855.5 5874.4 5883.3 5887.4 5897.6 4692.3 4871.4 4878.6 4879.5 5174.2 11362.5 11380.3 11391.3 11900.0 12029.0 2016.1 2113.0 2113.3 2258.0 2446.9 8888.3 8916.3 9101.6 9138.1 9141.0 1781.6 1799.3 1826.6 1847.3 1856.5 49723.5 51133.2 51216.0 52379.0 52840.5 9528.8 9585.0 9626.5 9630.4 9701.0 12263.5 12306.3 12355.1 12366.8 12417.6 6885.2 7071.3 7082.8 7119.8 7141.4 6749.4 6806.4 6807.0 6827.8 6860.1 3822.7 4059.7 4083.7 4120.4 4269.0 1636.9 1640.7 1652.8 1664.0 1664.1 414.4 415.2 429.6 930.9 1000.2 9826.6 10269.1 10355.6 10405.7 10595.0 418.6 439.9 444.3 449.8 450.7 5565.4 5789.8 5821.2 8831.8 9438.1 375004.0 383477.0 385084.0 502672.0 507007.0 57025.7 62283.7 62754.0 63011.4 63982.0 1103.6 1125.5 1140.0 1141.1 1142.7 14154.1 14194.4 14731.8 15299.0 15655.2 21094.2 31163.4 31171.2 31180.0 31474.1 38163.6 38754.6 39983.0 40605.0 41185.8 6815.0 7097.6 7105.9 7110.6 7188.3 8817.7 10404.7 10784.8 10870.5 11251.4 7563.5 9692.0 9823.2 9935.3 10129.9 9786.9 9830.0 10029.5 10275.9 10278.9 7346.0 8843.5 9840.4 9984.2 10255.6 6841.6 7099.1 7129.1 7188.4 7307.2 9161.0 9432.2 9473.8 9696.7 9959.9 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#3] mootools.html Cycles:180 Average:5058.82 Median:6098.16 stddev:2523.31 (41.4%) stddev-sans-first:2514.11 14:21:58 INFO - PROCESS | 27759 | Values: 1247.1 1400.3 1405.3 1520.3 1697.2 6357.2 6818.8 6969.5 6992.2 6996.7 6741.4 6964.5 6966.2 6972.2 6973.1 1916.3 1974.0 2196.6 2226.9 2253.2 2235.9 2240.0 2245.8 2247.2 2248.9 2117.8 2121.0 2122.3 2128.3 2135.2 2069.2 2074.1 2092.6 2221.1 2224.8 2176.2 2211.7 2227.8 2228.5 2228.9 7192.2 7230.1 7238.1 7240.5 7259.3 4369.2 4463.0 4473.3 4476.9 4480.2 2920.6 2951.7 2958.5 2971.6 3101.7 994.7 997.0 1015.2 1035.2 1047.7 9503.7 9516.4 9516.7 9523.4 9529.6 4075.0 4103.6 4174.9 4176.9 4187.9 8319.3 8380.1 8397.8 8408.2 8414.1 4549.3 4589.0 4590.9 4591.5 4596.6 4179.8 4182.8 4188.4 4190.0 4197.6 3238.2 3291.2 3423.3 3427.5 3486.9 1104.4 1154.2 1158.0 1158.2 1158.8 1172.5 1255.7 1274.7 1285.4 1294.4 6693.0 6746.3 6769.4 6787.2 6803.2 1094.4 1099.5 1104.8 1104.8 1121.0 5325.3 5391.9 5397.5 5403.3 5409.8 8310.7 8384.7 8532.1 8639.7 8642.7 8547.0 8549.4 8553.5 8554.6 8569.2 6589.0 6744.8 6746.3 6830.0 6833.5 6476.4 6536.1 6538.4 6542.8 6545.8 7512.1 7665.3 7713.3 7803.3 7830.3 7735.0 7775.7 7898.1 7999.2 8006.5 6404.3 6461.4 6463.7 6464.7 6473.1 6003.2 6205.3 6663.3 6687.0 6705.9 6446.5 6492.2 6571.3 6601.8 6614.1 6377.6 6433.0 6490.9 6511.3 6592.9 6497.4 6560.3 6564.8 6565.8 6573.6 6025.1 6075.7 6077.5 6079.7 6087.3 5977.3 6088.6 6107.7 6107.9 6109.3 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#4] prototype.html Cycles:180 Average:5217.32 Median:5907.44 stddev:1576.59 (26.7%) stddev-sans-first:1537.50 14:21:58 INFO - PROCESS | 27759 | Values: 315.9 320.7 321.3 322.7 323.1 5822.7 5851.8 5887.0 5910.3 5941.9 5829.1 5899.0 5899.7 5903.7 5904.6 4309.7 4385.6 4401.4 4487.9 4490.3 4458.1 4460.1 4489.8 4490.7 4502.8 4434.9 4437.4 4440.0 4447.0 4457.8 4262.1 4352.7 4389.5 4451.1 4458.3 3913.2 3917.3 3924.2 3932.5 3942.3 5504.2 5541.4 5559.4 5559.9 5571.6 5202.4 5210.9 5214.3 5216.1 5222.3 6105.7 6121.9 6162.8 6164.6 6170.0 4390.3 4390.4 4394.4 4396.2 4396.8 6385.5 6479.5 6483.7 6485.9 6490.6 4327.3 4393.7 4400.0 4409.6 4469.6 4512.8 4513.6 4515.5 4518.9 4520.5 5170.1 5179.8 5183.8 5188.8 5190.5 6264.1 6272.1 6280.2 6283.5 6286.2 1578.2 1594.3 1605.0 1612.6 1613.7 1053.6 1059.9 1065.9 1066.7 1081.8 5929.7 5940.3 5946.1 5947.6 5950.3 6307.4 6349.1 6363.4 6429.9 6442.6 5859.9 5879.9 5883.9 5920.9 5932.6 3246.1 3357.3 3378.2 3464.0 3469.9 6617.7 6650.1 6651.9 6655.7 6667.5 6537.9 6541.1 6579.5 6591.8 6605.2 6568.2 6716.0 6719.1 6726.8 6735.5 6468.8 6484.7 6488.5 6490.7 6490.8 6362.5 6384.0 6388.2 6390.0 6396.2 6567.6 6646.9 6672.6 6697.1 6714.8 4538.5 4541.7 4544.2 4545.5 4546.1 6403.7 6457.1 6468.9 6469.5 6470.6 6143.9 6298.8 6308.2 6310.1 6320.2 6291.5 6293.2 6294.5 6302.1 6302.7 6183.9 6190.5 6192.3 6193.8 6194.3 6175.3 6320.7 6322.5 6340.0 6346.5 6166.2 6175.6 6176.5 6177.3 6181.5 14:21:58 INFO - PROCESS | 27759 | 14:21:58 INFO - PROCESS | 27759 | [#5] yui.html Cycles:180 Average:13084.65 Median:42291.58 stddev:14581.66 (34.5%) stddev-sans-first:14593.01 14:21:58 INFO - PROCESS | 27759 | Values: 722.5 743.1 768.8 777.0 789.5 13362.5 13364.6 13423.4 13461.7 13463.9 12689.5 12719.2 12763.0 12824.8 12848.4 651.9 652.0 775.4 778.4 804.8 795.6 796.6 800.3 803.3 803.3 832.8 836.0 836.9 837.8 838.2 687.6 691.5 823.1 837.8 840.2 615.1 615.3 615.4 615.6 615.9 12902.1 12977.2 12977.2 12992.1 13020.3 12740.7 12994.4 13028.0 13235.5 13261.5 10185.6 10214.4 10248.5 10835.8 11074.5 3608.0 3622.5 3632.3 3640.5 3756.3 42181.8 42259.4 42323.8 42469.0 43650.6 9229.6 9353.0 9476.4 9517.8 9595.9 15863.8 15886.8 15970.3 17206.2 17488.6 6933.7 6956.9 7180.2 7473.0 7577.6 4127.1 4138.5 4157.5 4166.5 4183.7 2852.8 2869.2 2872.0 2872.1 2887.7 499.7 512.9 518.0 532.4 533.0 559.2 600.3 610.0 645.4 657.9 9096.8 9158.1 9187.8 9205.9 9412.1 648.2 674.1 674.4 685.2 695.2 3729.9 3786.0 3872.3 3960.2 3987.8 51222.0 51847.5 51856.0 52161.2 52235.5 47015.8 48054.5 48741.3 48888.8 49029.5 41555.8 41614.8 42386.0 42557.8 42644.0 7591.8 7608.7 7861.1 7907.9 7954.0 33916.7 34017.5 34935.5 35356.5 36084.8 40701.8 40740.4 41240.0 41319.0 41672.4 10656.8 10701.7 11027.7 11051.0 11451.5 10962.6 11409.5 11500.4 11541.9 11629.5 11314.2 11706.7 11774.8 12015.6 12075.0 11493.5 11759.1 11793.6 11849.3 12331.4 11035.3 11062.0 11111.9 11389.8 11482.4 9145.8 9286.4 9305.9 9483.1 9523.2 9300.3 9349.8 9831.9 10257.4 10272.1 14:21:58 INFO - PROCESS | 27759 | -------- Summary: end -------- 14:21:58 INFO - PROCESS | 27759 | 14:21:59 INFO - TEST-INFO | 27759: exit 0 14:21:59 INFO - TEST-OK | dromaeo_css | took 1112439ms 14:21:59 INFO - TEST-START | kraken 14:21:59 INFO - operating with platform_type : linux_ 14:21:59 INFO - Initialising browser for kraken test... 14:21:59 INFO - TEST-INFO | started process 27950 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNfNI0v/profile http://localhost:57685/getInfo.html) 14:22:03 INFO - PROCESS | 27950 | __metrics Screen width/height:1600/1200 14:22:03 INFO - PROCESS | 27950 | colorDepth:24 14:22:03 INFO - PROCESS | 27950 | Browser inner width/height: 1024/697 14:22:03 INFO - PROCESS | 27950 | __metrics 14:22:03 INFO - PROCESS | 27950 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:22:03 INFO - PROCESS | 27950 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:04 INFO - TEST-INFO | 27950: exit 0 14:22:04 INFO - Browser initialized. 14:22:04 INFO - Running cycle 1/1 for kraken test... 14:22:04 INFO - TEST-INFO | started process 28031 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNfNI0v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:16 INFO - PROCESS | 28031 | RSS: Main: 148951040 14:22:16 INFO - PROCESS | 28031 | 14:22:18 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57685/tests/kraken/driver.html?testName=audio-beat-detection) 14:22:19 INFO - PROCESS | 28031 | RSS: Main: 185724928 14:22:19 INFO - PROCESS | 28031 | 14:22:21 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57685/tests/kraken/driver.html?testName=audio-dft) 14:22:22 INFO - PROCESS | 28031 | RSS: Main: 176754688 14:22:22 INFO - PROCESS | 28031 | 14:22:25 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57685/tests/kraken/driver.html?testName=audio-fft) 14:22:25 INFO - PROCESS | 28031 | RSS: Main: 160620544 14:22:25 INFO - PROCESS | 28031 | 14:22:27 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57685/tests/kraken/driver.html?testName=audio-oscillator) 14:22:28 INFO - PROCESS | 28031 | RSS: Main: 162623488 14:22:28 INFO - PROCESS | 28031 | 14:22:30 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:31 INFO - PROCESS | 28031 | RSS: Main: 165228544 14:22:31 INFO - PROCESS | 28031 | 14:22:34 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57685/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:34 INFO - PROCESS | 28031 | RSS: Main: 164204544 14:22:34 INFO - PROCESS | 28031 | 14:22:37 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57685/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:38 INFO - PROCESS | 28031 | RSS: Main: 164462592 14:22:38 INFO - PROCESS | 28031 | 14:22:41 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57685/tests/kraken/driver.html?testName=json-parse-financial) 14:22:41 INFO - PROCESS | 28031 | RSS: Main: 165580800 14:22:41 INFO - PROCESS | 28031 | 14:22:43 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:43 INFO - PROCESS | 28031 | RSS: Main: 176672768 14:22:43 INFO - PROCESS | 28031 | 14:22:45 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:46 INFO - PROCESS | 28031 | RSS: Main: 175411200 14:22:46 INFO - PROCESS | 28031 | 14:22:48 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:49 INFO - PROCESS | 28031 | RSS: Main: 182272000 14:22:49 INFO - PROCESS | 28031 | 14:22:51 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:52 INFO - PROCESS | 28031 | RSS: Main: 188047360 14:22:52 INFO - PROCESS | 28031 | 14:22:54 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:55 INFO - PROCESS | 28031 | RSS: Main: 189390848 14:22:55 INFO - PROCESS | 28031 | 14:22:56 INFO - PROCESS | 28031 | Cycle 1(1): loaded http://localhost:57685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57685/tests/kraken/driver.html?testName=ai-astar) 14:22:57 INFO - PROCESS | 28031 | RSS: Main: 246321152 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | __start_tp_report 14:22:57 INFO - PROCESS | 28031 | _x_x_mozilla_page_load 14:22:57 INFO - PROCESS | 28031 | _x_x_mozilla_page_load_details 14:22:57 INFO - PROCESS | 28031 | |i|pagename|runs| 14:22:57 INFO - PROCESS | 28031 | |0;ai-astar;111;113;108;111;113;114;102;115;112;118 14:22:57 INFO - PROCESS | 28031 | |1;audio-beat-detection;144;131;150;170;128;159;155;128;174;127 14:22:57 INFO - PROCESS | 28031 | |2;audio-dft;162;160;161;161;162;161;158;163;161;160 14:22:57 INFO - PROCESS | 28031 | |3;audio-fft;71;72;81;106;71;72;72;94;91;73 14:22:57 INFO - PROCESS | 28031 | |4;audio-oscillator;96;97;139;95;97;97;147;96;97;141 14:22:57 INFO - PROCESS | 28031 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;108;109;109 14:22:57 INFO - PROCESS | 28031 | |6;imaging-darkroom;147;145;146;146;146;146;145;146;145;145 14:22:57 INFO - PROCESS | 28031 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;96;95 14:22:57 INFO - PROCESS | 28031 | |8;json-parse-financial;57;57;55;56;57;58;57;65;55;56 14:22:57 INFO - PROCESS | 28031 | |9;json-stringify-tinderbox;67;66;66;66;67;66;69;68;66;66 14:22:57 INFO - PROCESS | 28031 | |10;stanford-crypto-aes;85;85;88;85;91;93;87;87;86;87 14:22:57 INFO - PROCESS | 28031 | |11;stanford-crypto-ccm;122;120;118;118;123;126;129;120;117;126 14:22:57 INFO - PROCESS | 28031 | |12;stanford-crypto-pbkdf2;142;144;162;155;144;141;153;153;151;151 14:22:57 INFO - PROCESS | 28031 | |13;stanford-crypto-sha256-iterative;70;70;68;68;69;68;67;70;67;72 14:22:57 INFO - PROCESS | 28031 | __end_tp_report 14:22:57 INFO - PROCESS | 28031 | __start_cc_report 14:22:57 INFO - PROCESS | 28031 | _x_x_mozilla_cycle_collect,953 14:22:57 INFO - PROCESS | 28031 | __end_cc_report 14:22:57 INFO - PROCESS | 28031 | __startTimestamp1452464577200__endTimestamp 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | ------- Summary: start ------- 14:22:57 INFO - PROCESS | 28031 | Number of tests: 14 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:4.32 (3.8%) stddev-sans-first:4.58 14:22:57 INFO - PROCESS | 28031 | Values: 111.0 113.0 108.0 111.0 113.0 114.0 102.0 115.0 112.0 118.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:152.50 stddev:17.83 (11.7%) stddev-sans-first:18.88 14:22:57 INFO - PROCESS | 28031 | Values: 144.0 131.0 150.0 170.0 128.0 159.0 155.0 128.0 174.0 127.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.37 (0.9%) stddev-sans-first:1.39 14:22:57 INFO - PROCESS | 28031 | Values: 162.0 160.0 161.0 161.0 162.0 161.0 158.0 163.0 161.0 160.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#3] audio-fft Cycles:10 Average:80.30 Median:72.50 stddev:12.45 (17.2%) stddev-sans-first:12.75 14:22:57 INFO - PROCESS | 28031 | Values: 71.0 72.0 81.0 106.0 71.0 72.0 72.0 94.0 91.0 73.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.50 stddev:22.27 (23.1%) stddev-sans-first:23.02 14:22:57 INFO - PROCESS | 28031 | Values: 96.0 97.0 139.0 95.0 97.0 97.0 147.0 96.0 97.0 141.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:22:57 INFO - PROCESS | 28031 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 108.0 109.0 109.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 14:22:57 INFO - PROCESS | 28031 | Values: 147.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 145.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:22:57 INFO - PROCESS | 28031 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:2.87 (5.0%) stddev-sans-first:3.04 14:22:57 INFO - PROCESS | 28031 | Values: 57.0 57.0 55.0 56.0 57.0 58.0 57.0 65.0 55.0 56.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:66.50 stddev:1.06 (1.6%) stddev-sans-first:1.12 14:22:57 INFO - PROCESS | 28031 | Values: 67.0 66.0 66.0 66.0 67.0 66.0 69.0 68.0 66.0 66.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:2.67 (3.1%) stddev-sans-first:2.69 14:22:57 INFO - PROCESS | 28031 | Values: 85.0 85.0 88.0 85.0 91.0 93.0 87.0 87.0 86.0 87.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.50 stddev:4.04 (3.3%) stddev-sans-first:4.28 14:22:57 INFO - PROCESS | 28031 | Values: 122.0 120.0 118.0 118.0 123.0 126.0 129.0 120.0 117.0 126.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.00 stddev:6.70 (4.4%) stddev-sans-first:6.52 14:22:57 INFO - PROCESS | 28031 | Values: 142.0 144.0 162.0 155.0 144.0 141.0 153.0 153.0 151.0 151.0 14:22:57 INFO - PROCESS | 28031 | 14:22:57 INFO - PROCESS | 28031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.60 (2.3%) stddev-sans-first:1.64 14:22:57 INFO - PROCESS | 28031 | Values: 70.0 70.0 68.0 68.0 69.0 68.0 67.0 70.0 67.0 72.0 14:22:57 INFO - PROCESS | 28031 | -------- Summary: end -------- 14:22:57 INFO - PROCESS | 28031 | 14:22:58 INFO - TEST-INFO | 28031: exit 0 14:22:58 INFO - TEST-OK | kraken | took 58687ms 14:22:58 INFO - TEST-START | v8_7 14:22:58 INFO - operating with platform_type : linux_ 14:22:58 INFO - Initialising browser for v8_7 test... 14:22:58 INFO - TEST-INFO | started process 28279 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpydNECp/profile http://localhost:57685/getInfo.html) 14:23:01 INFO - PROCESS | 28279 | __metrics Screen width/height:1600/1200 14:23:01 INFO - PROCESS | 28279 | colorDepth:24 14:23:01 INFO - PROCESS | 28279 | Browser inner width/height: 1024/697 14:23:01 INFO - PROCESS | 28279 | __metrics 14:23:02 INFO - PROCESS | 28279 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 14:23:02 INFO - PROCESS | 28279 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:02 INFO - TEST-INFO | 28279: exit 0 14:23:02 INFO - Browser initialized. 14:23:02 INFO - Running cycle 1/1 for v8_7 test... 14:23:02 INFO - TEST-INFO | started process 28363 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpydNECp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:14 INFO - PROCESS | 28363 | RSS: Main: 148254720 14:23:14 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:57685/tests/v8_7/run.html (next: http://localhost:57685/tests/v8_7/run.html) 14:23:37 INFO - PROCESS | 28363 | RSS: Main: 574451712 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | __start_tp_report 14:23:37 INFO - PROCESS | 28363 | _x_x_mozilla_page_load 14:23:37 INFO - PROCESS | 28363 | _x_x_mozilla_page_load_details 14:23:37 INFO - PROCESS | 28363 | |i|pagename|runs| 14:23:37 INFO - PROCESS | 28363 | |0;Richards;167.47613465081227 14:23:37 INFO - PROCESS | 28363 | |1;DeltaBlue;191.131498470948 14:23:37 INFO - PROCESS | 28363 | |2;Encrypt;280.19052956010086 14:23:37 INFO - PROCESS | 28363 | |3;Decrypt;5154.639175257732 14:23:37 INFO - PROCESS | 28363 | |4;RayTrace;1102.5358324145534 14:23:37 INFO - PROCESS | 28363 | |5;Earley;780.64012490242 14:23:37 INFO - PROCESS | 28363 | |6;Boyer;12132.530120481928 14:23:37 INFO - PROCESS | 28363 | |7;RegExp;42142.857142857145 14:23:37 INFO - PROCESS | 28363 | |8;Splay;591.8966529653552 14:23:37 INFO - PROCESS | 28363 | |9;NavierStokes;4878.048780487805 14:23:37 INFO - PROCESS | 28363 | __end_tp_report 14:23:37 INFO - PROCESS | 28363 | __startTimestamp1452464617285__endTimestamp 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | ------- Summary: start ------- 14:23:37 INFO - PROCESS | 28363 | Number of tests: 10 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 167.5 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#1] DeltaBlue Cycles:1 Average:191.13 Median:191.13 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 191.1 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#2] Encrypt Cycles:1 Average:280.19 Median:280.19 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 280.2 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 5154.6 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#4] RayTrace Cycles:1 Average:1102.54 Median:1102.54 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 1102.5 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 780.6 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 12132.5 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#7] RegExp Cycles:1 Average:42142.86 Median:42142.86 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 42142.9 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#8] Splay Cycles:1 Average:591.90 Median:591.90 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 591.9 14:23:37 INFO - PROCESS | 28363 | 14:23:37 INFO - PROCESS | 28363 | [#9] NavierStokes Cycles:1 Average:4878.05 Median:4878.05 stddev:0.00 (0.0%) 14:23:37 INFO - PROCESS | 28363 | Values: 4878.0 14:23:37 INFO - PROCESS | 28363 | -------- Summary: end -------- 14:23:37 INFO - PROCESS | 28363 | 14:23:38 INFO - TEST-INFO | 28363: exit 0 14:23:38 INFO - TEST-OK | v8_7 | took 40069ms 14:23:38 INFO - SUITE-END | took 1211s 14:23:38 INFO - Completed test suite (00:20:11) 14:23:38 INFO - Working with test: dromaeo_css 14:23:38 INFO - Generating results file: dromaeo_css 14:23:38 INFO - Working with test: kraken 14:23:38 INFO - Generating results file: kraken 14:23:38 INFO - javascript benchmark 14:23:38 INFO - Working with test: v8_7 14:23:38 INFO - Generating results file: v8_7 14:23:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 14:23:38 INFO - process_Request line: dromaeo_css 6574.98 graph.html#tests=[[72,64,35]] 14:23:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:38 INFO - process_Request line: kraken 1511.70 graph.html#tests=[[232,64,35]] 14:23:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:38 INFO - process_Request line: v8_7 20100.64 graph.html#tests=[[230,64,35]] 14:23:38 INFO - RETURN: dromaeo_css: 6574.98 14:23:38 INFO - RETURN: kraken: 1511.70 14:23:38 INFO - RETURN: v8_7: 20100.64 14:23:38 INFO - javascript benchmark 14:23:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3042.345895632439, 3086.2438702517857, 3131.6398614159366, 3149.7637677174203, 3177.698118678725, 4939.678920870141, 5037.748112594374, 5082.974585127074, 5113.667611605243, 5146.5110814472655, 5031.1698569736045, 5062.974685126578, 5122.436531981479, 5129.358830146231, 5191.974040129803, 4644.6748727589165, 4672.742999135046, 4678.672492925497, 4711.151992641323, 4800.159972004903, 4750.857474275777, 4762.095201911626, 4764.237721964487, 4796.808127674889, 4810.87972800681, 4591.632669386441, 4601.700889442209, 4674.368960190365, 4685.016146609216, 4703.952960470403, 4662.836800711959, 4692.671512994092, 4704.364910737041, 4705.858824235278, 4724.480307166209, 4632.698874573176, 4657.091867085919, 4662.230731929261, 4686.742229177394, 4701.412323459567, 4792.688475249098, 4902.068606964701, 4919.926201106986, 4965.577925876305, 5073.898522029575, 5366.034113859504, 5416.756245968941, 5417.214503896913, 5436.075867102562, 5439.347278326626, 5453.130344687405, 5453.918191227135, 5461.344638643388, 5462.5083742462975, 5497.092979658391, 4995.650304478688, 5041.269015992661, 5122.692638441706, 5153.716545589991, 5164.690118592859, 5573.191887176336, 5576.7211639417865, 5579.832605021856, 5586.217929489874, 5627.690477023803, 5364.409914909357, 5367.570594352443, 5370.650907690988, 5371.4628537146755, 5372.785088596413, 5318.042752304622, 5433.239346491494, 5459.645123066988, 5460.563154947595, 5582.162675598612, 5449.4005659377435, 5454.509094181542, 5458.536024437888, 5460.5085542300585, 5461.399246082928, 5393.271908292409, 5439.374471935699, 5445.237666726662, 5447.319085114361, 5480.342358916876, 4223.303154979455, 4281.892952676208, 4303.698741088094, 4344.218040752695, 4382.802773875183, 3823.1206822430995, 3835.328817456934, 3844.1927195288745, 3871.5741268460447, 3876.8255428505786, 4993.251012348104, 5104.948950510522, 5115.769790359368, 5119.436861945183, 5165.302684137669, 5462.071447853875, 5472.589555783332, 5504.366997795305, 5522.30971128609, 5561.555075593943, 5056.57019153376, 5109.38687357512, 5119.564836988823, 5124.180131178993, 5161.690298582097, 4614.538546145359, 4689.460712018094, 4698.7415692137265, 4702.85891423251, 4704.059188162313, 5585.162225666182, 5625.184348269478, 5626.381098079208, 5637.154426836008, 5671.262735844314, 5492.340919089735, 5512.7519261634125, 5512.834614961557, 5515.779368825202, 5524.33707955048, 5535.972320138373, 5642.492175704207, 5691.459311365414, 5710.2862142232225, 5717.571182161271, 5359.678419294699, 5395.973020134874, 5400.864978375572, 5415.566754659539, 5452.754626041917, 5468.125099983983, 5468.507834294933, 5468.617196796186, 5469.013888612838, 5478.287822583198, 5195.740212989411, 5296.04671159195, 5314.12316967696, 5319.547838433622, 5396.1905714143195, 5372.704501252469, 5398.676079435247, 5402.918956215739, 5405.081136206933, 5411.540019098421, 5291.100512912737, 5311.973440132774, 5317.654352467077, 5324.227986941949, 5363.27595774581, 5238.109521381451, 5267.552258058108, 5280.128778751617, 5334.866628334323, 5390.0, 5179.585633149414, 5302.416734159162, 5330.360356757214, 5333.43998880112, 5350.250964865], "unit": "score", "name": "dojo.html", "value": 5053.417759532676}, {"lowerIsBetter": false, "replicates": [531.5614617940198, 559.0998492427193, 560.2296841842467, 569.9059655156897, 584.3251045042975, 28234.152975410718, 28921.710782892165, 28987.710122898763, 28997.130086097426, 29027.564586531218, 36324.27351452976, 36545.45181822268, 36754.44868326977, 36755.0, 36797.0, 8432.241098301152, 8486.769418434324, 8557.93025871766, 8559.058503564604, 8574.657013719443, 7495.5127916685515, 7683.346915512188, 8286.5028098314, 8428.072911979709, 8428.452150610221, 10012.249081318894, 10193.0, 10210.795784084314, 10215.744606384826, 10229.897701022968, 9855.457949812757, 9962.701118966443, 9970.800583988352, 9971.302008859382, 9977.401355918668, 7539.849203015964, 7753.573553454557, 9791.706248812547, 9828.557714902847, 10080.59677612902, 36446.271074578624, 36738.63261367379, 36799.08002299937, 36923.63076369229, 36974.26051478982, 3412.8805491807916, 3733.663970242691, 3785.9432108518117, 3921.3725803871243, 3938.113924367023, 27902.302442438897, 28062.298442538897, 28521.286967825763, 28601.856990714914, 29638.259043523867, 3419.9658003419895, 3430.811305378203, 3448.620651728308, 3517.9120521986897, 3590.2101537661674, 303342.0, 303984.4800776004, 306784.0, 307494.0, 307766.0, 54710.17934730982, 55115.44884551183, 55349.72325138348, 55379.123461358125, 55511.16733249005, 55124.17313740297, 55960.16059759026, 64703.67648161729, 65719.34280657228, 65724.78440194976, 14019.299035048207, 14081.788773168411, 14195.645108872155, 14207.431702731776, 14226.644333891736, 10584.312019718695, 10597.311174773615, 10623.0, 10625.681229563126, 10629.787404252027, 19164.71252931207, 19464.0, 19516.219351226075, 19531.316403925794, 19551.315703950295, 7794.727184548514, 7977.242161994717, 8037.115917249098, 8045.597720113971, 8116.472429292077, 946.4983558713893, 952.3857112162755, 1028.5063169678597, 1066.664000839733, 1072.5495291977231, 27863.442731145667, 28446.0, 30597.0, 32213.194670132965, 32942.50586241209, 1016.1159790981893, 1048.8374301983206, 1058.5501162006117, 1070.5824728355947, 1100.983485247722, 13787.310634468236, 13842.515511957034, 14139.64650883736, 14158.663820469714, 14258.643533911527, 453055.0, 463739.0, 463841.0, 463930.0, 464287.0, 50981.49018509842, 51676.0, 51782.22326665103, 51963.22055169175, 51992.74003630033, 1359.0554564577722, 1366.187118664393, 1367.405178747248, 1375.6010756880391, 1377.6486995816003, 23037.539249215257, 28153.0, 29844.253893651963, 30230.54654180145, 30241.243968900075, 44493.77753111214, 45245.77377113225, 45294.32058519059, 45382.31926521039, 45489.77255113703, 224307.0, 225194.0, 225835.0, 226465.0, 226666.0, 27425.45149096967, 27745.861270693516, 30126.397472049997, 31261.687383126788, 31886.811318867927, 36290.63709362978, 37292.627073728916, 37398.0, 37638.81180594079, 37824.62175378321, 31535.75908407218, 31871.68128318687, 32164.839175803972, 33016.50475242825, 34655.0, 34173.0, 34278.14304642404, 34297.31405371929, 34421.16759332764, 35125.0, 33240.83379583087, 34107.48838767371, 34203.315933680686, 34285.48571771375, 34328.48507272443, 28941.276468088465, 31190.376192476477, 31391.68608313979, 31854.522182166824, 31866.203344915633, 23797.643035354136, 24007.879960600087, 24145.879270603535, 24371.878140609184, 24510.264692059267], "unit": "score", "name": "ext.html", "value": 18047.633553212716}, {"lowerIsBetter": false, "replicates": [348.1644054269754, 349.8303322888399, 355.2132027558957, 357.0965457392797, 358.21908240036726, 13270.402831872565, 13761.518346857836, 15832.604184895383, 15881.682366352681, 16704.248308826103, 15007.174605396725, 15008.324625391857, 16007.35970561179, 16031.278592463337, 16038.919805400958, 4987.900241995158, 5381.5425688816495, 5395.352557693062, 5399.406065332811, 5400.756965936543, 2988.5068963620975, 3920.8627698030573, 4074.7962601869935, 5666.660000399968, 5892.911606325887, 5619.129034999562, 5803.970980145094, 5846.941530584703, 5850.034744267191, 5941.940580594182, 5855.47300742933, 5874.441928016874, 5883.264591926009, 5887.381824908387, 5897.557683173779, 4692.296155576657, 4871.36672232611, 4878.634102442331, 4879.536444037811, 5174.172132458826, 11362.488688008976, 11380.260283081574, 11391.259568128045, 11900.047996160287, 12029.0, 2016.1229865008768, 2112.9788702112937, 2113.260358874397, 2257.954840903189, 2446.8898899549386, 8888.333374996837, 8916.286697064219, 9101.590428430736, 9138.086191380875, 9141.040190779939, 1781.6347648731978, 1799.2712951254762, 1826.5707558723689, 1847.2703282203588, 1856.5004965639866, 49723.508294750856, 51133.23300150501, 51216.0, 52379.0, 52840.471595284325, 9528.761780955532, 9584.952075239718, 9626.518674066268, 9630.422174669402, 9701.0, 12263.509459621693, 12306.261624302571, 12355.135140540076, 12366.814497782541, 12417.565385211474, 6885.173779146434, 7071.292870712888, 7082.752103676346, 7119.786406407816, 7141.392981596518, 6749.358810913053, 6806.387425131663, 6807.0, 6827.829304267433, 6860.0738900248825, 3822.694184465236, 4059.6752259819145, 4083.714140010171, 4120.443740095108, 4268.9786551067045, 1636.8526832584887, 1640.7374820028977, 1652.7686123942658, 1663.9584010399838, 1664.118017450753, 414.41153561942116, 415.1779476636217, 429.63266407222, 930.9255259579218, 1000.1998401278947, 9826.606935722633, 10269.127124194378, 10355.637552685619, 10405.687829365132, 10595.0, 418.6483353982669, 439.9032212913154, 444.3024451611004, 449.8133274691032, 450.6710101625832, 5565.443455654402, 5789.768409263666, 5821.166332605216, 8831.779205519784, 9438.103380178873, 375004.0, 383477.0, 385084.0, 502672.0, 507007.0, 57025.71487142538, 62283.6885815568, 62754.0, 63011.369886301465, 63982.0, 1103.5971870267456, 1125.454154734953, 1140.0423644138798, 1141.0928311991986, 1142.6743378137357, 14154.079984800956, 14194.43222271139, 14731.779023314444, 15299.005564638263, 15655.21723913777, 21094.156233750477, 31163.37673246477, 31171.220719482193, 31180.0, 31474.05577832669, 38163.61836381712, 38754.61245387623, 39983.0, 40605.0, 41185.79407103065, 6815.0, 7097.609631470319, 7105.8578828422105, 7110.608916509642, 7188.317109874553, 8817.735467935972, 10404.68785936423, 10784.838227426439, 10870.45647717595, 11251.381174035507, 7563.470557060953, 9691.951540242253, 9823.21414286841, 9935.304528683211, 10129.898701012895, 9786.902130978599, 9829.950850245703, 10029.539738932495, 10275.897241027495, 10278.948605256926, 7346.044399496266, 8843.51360675169, 9840.40957542521, 9984.151347135576, 10255.58977640886, 6841.623710695761, 7099.07711997437, 7129.108861392326, 7188.424926005802, 7307.196208416964, 9161.0, 9432.245420366491, 9473.763155921157, 9696.709098726767, 9959.850602241117], "unit": "score", "name": "jquery.html", "value": 7315.118669217591}, {"lowerIsBetter": false, "replicates": [1247.0647014738945, 1400.3418393355123, 1405.3184205660257, 1520.2702702702702, 1697.2107969794051, 6357.173567436233, 6818.829529261771, 6969.546979446332, 6992.195897471793, 6996.720131194759, 6741.359570840775, 6964.5473044252085, 6966.198887127982, 6972.163340399146, 6973.093497845286, 1916.338863092238, 1974.042589344167, 2196.5936301784222, 2226.8886555672193, 2253.211376018389, 2235.8993845277, 2240.0367841828006, 2245.8091062259728, 2247.202243203664, 2248.910043598254, 2117.7776333484994, 2120.957580848382, 2122.289033173881, 2128.31893793986, 2135.1993002624017, 2069.1619893942902, 2074.087401543316, 2092.5501017281204, 2221.1004543160047, 2224.7663995280423, 2176.205684924991, 2211.6793065005645, 2227.8217742580555, 2228.5097278598846, 2228.855124416924, 7192.208857025723, 7230.060092188034, 7238.059052323217, 7240.4569657275915, 7259.310365515267, 4369.2353838078525, 4463.04044630406, 4473.329000649896, 4476.910461790746, 4480.238359478896, 2920.6057182280333, 2951.719586639266, 2958.4970555005702, 2971.643402791657, 3101.720845123927, 994.7065615643403, 997.042838874674, 1015.1675625986694, 1035.249444152983, 1047.7328281288299, 9503.66737164196, 9516.429014259167, 9516.714498565123, 9523.428594284296, 9529.618815247382, 4074.9796251019147, 4103.5691252418665, 4174.937375939363, 4176.895577610584, 4187.853425130106, 8319.251267385964, 8380.078191398941, 8397.832043359098, 8408.2432581068, 8414.074451810297, 4549.3176023596725, 4589.036302376471, 4590.908181836411, 4591.517890621437, 4596.632269418438, 4179.832806687698, 4182.769947652909, 4188.4136220929095, 4189.97905010473, 4197.580241975839, 3238.158078899503, 3291.1772056985756, 3423.3324501722423, 3427.503012063287, 3486.936484372291, 1104.3539529375246, 1154.1747650429984, 1157.9594714185132, 1158.1932185790195, 1158.7798318319492, 1172.472387425662, 1255.6672481792332, 1274.6622145131548, 1285.3701686173708, 1294.4433893425917, 6692.96653516739, 6746.291639377893, 6769.39075483199, 6787.185537735503, 6803.183617965777, 1094.4363652718855, 1099.4777480696605, 1104.812181929074, 1104.828751543512, 1121.041509509374, 5325.281087053276, 5391.865203369947, 5397.541208997201, 5403.2705584746345, 5409.756560954766, 8310.70912518059, 8384.706535271236, 8532.104129066483, 8639.697610583726, 8642.697505587274, 8547.034182138019, 8549.358798090168, 8553.486790792573, 8554.57227138653, 8569.228769410784, 6589.044588534635, 6744.7976560703255, 6746.291639377795, 6829.965850170717, 6833.521653484208, 6476.352364763486, 6536.084948107174, 6538.4115429609665, 6542.803715888531, 6545.803625891231, 7512.060992375953, 7665.271799179069, 7713.267239612228, 7803.297703206738, 7830.256125668053, 7735.0, 7775.727849525239, 7898.091719452107, 7999.200079991954, 8006.519608823489, 6404.263509696445, 6461.418472337325, 6463.741450341934, 6464.676766161579, 6473.1261279728515, 6003.219581454383, 6205.317415084247, 6663.333666633298, 6687.0, 6705.865882682417, 6446.4520515756685, 6492.156019717407, 6571.277159512545, 6601.768938087144, 6614.074029635759, 6377.617342959437, 6433.0, 6490.870182596416, 6511.2512061113575, 6592.901106483502, 6497.382748638872, 6560.278369379269, 6564.770233041821, 6565.835854103495, 6573.605583664996, 6025.096235564701, 6075.696215189311, 6077.544184186116, 6079.696015199311, 6087.269527656709, 5977.3126090500145, 6088.6042407243385, 6107.725152368065, 6107.877842443215, 6109.2974307955155], "unit": "score", "name": "mootools.html", "value": 4222.276491682975}, {"lowerIsBetter": false, "replicates": [315.9162821852211, 320.6809224821303, 321.2899492122409, 322.66765231811235, 323.14205783644417, 5822.65064096154, 5851.7951871684445, 5887.028640274355, 5910.290765108182, 5941.88116237675, 5829.125631155329, 5898.970505147479, 5899.705014749256, 5903.704814759266, 5904.5866789324655, 4309.698321117523, 4385.605295523403, 4401.383806267125, 4487.865364039068, 4490.281554951217, 4458.108378324332, 4460.063386688799, 4489.7979590918485, 4490.708103973231, 4502.774861256924, 4434.866953991385, 4437.445319335083, 4439.955600443986, 4446.955530444687, 4457.799399027035, 4262.062346283828, 4352.717073390236, 4389.473263208403, 4451.109778044404, 4458.331250312447, 3913.1977944521304, 3917.2557214129224, 3924.2151569686175, 3932.5477570079233, 3942.349512330462, 5504.2018907258625, 5541.390447050821, 5559.388467268597, 5559.861003474905, 5571.637843540157, 5202.401723801736, 5210.895782084375, 5214.270002199695, 5216.061109000379, 5222.321098257202, 6105.725242364104, 6121.877562448771, 6162.815115546541, 6164.568480206387, 6170.043643235305, 4390.319500477431, 4390.363397307373, 4394.428724265825, 4396.20868243716, 4396.824127034914, 6385.5210859185745, 6479.481641468671, 6483.675816209124, 6485.870282594322, 6490.610563366213, 4327.307630779061, 4393.6704747144095, 4399.978000110043, 4409.559044095565, 4469.642428605769, 4512.81948722054, 4513.571210734975, 4515.458145022619, 4518.864434066983, 4520.547945205453, 5170.069387510284, 5179.818706345335, 5183.844484665466, 5188.792448302026, 5190.455002224788, 6264.060390941395, 6272.1219029335925, 6280.214973128359, 6283.497320214372, 6286.245650521967, 1578.2424436270426, 1594.3224129745045, 1604.9567780942248, 1612.5887898585786, 1613.6772645470953, 1053.5680371047833, 1059.8887116852773, 1065.8827528971806, 1066.664000839733, 1081.7836432713489, 5929.703514824328, 5940.34656187819, 5946.137810017523, 5947.613405128739, 5950.315713692894, 6307.369263073748, 6349.079383489368, 6363.395477429637, 6429.935700643027, 6442.645654488954, 5859.941400586024, 5879.853003674857, 5883.941160588425, 5920.911186332209, 5932.614380065282, 3246.123546642393, 3357.3285342931513, 3378.239896023375, 3463.982680086634, 3469.87855425064, 6617.702203400859, 6650.068990341356, 6651.86696266072, 6655.73377064912, 6667.533272670964, 6537.901931471032, 6541.116949211891, 6579.539432239697, 6591.802245932629, 6605.207375115017, 6568.211814582281, 6715.966420167965, 6719.0593316935665, 6726.831829204309, 6735.528513004043, 6468.8059358219325, 6484.708188131451, 6488.545801793829, 6490.7079181436, 6490.8052758417325, 6362.491000720024, 6384.042393640991, 6388.201474815648, 6390.0, 6396.168498095218, 6567.573107747981, 6646.933530664632, 6672.566283191577, 6697.06241126233, 6714.764983225564, 4538.478075021415, 4541.72749635023, 4544.2274813281165, 4545.477270113979, 4546.1135078659345, 6403.7118329676205, 6457.128287681291, 6468.902966455413, 6469.547131700736, 6470.579412338183, 6143.938560614337, 6298.779542715983, 6308.211473565804, 6310.148130002391, 6320.209973753281, 6291.465225455704, 6293.150424692608, 6294.527910406646, 6302.117703521419, 6302.747890084345, 6183.876322473615, 6190.473809726223, 6192.256929168529, 6193.752249910133, 6194.287656919512, 6175.289841668266, 6320.747170113144, 6322.494200464043, 6340.048992651139, 6346.492280617632, 6166.167567378347, 6175.5677102602385, 6176.505879529716, 6177.2587289525545, 6181.474574661204], "unit": "score", "name": "prototype.html", "value": 4702.254238909117}, {"lowerIsBetter": false, "replicates": [722.4906440959123, 743.1379599664388, 768.7539987204095, 776.9883451748221, 789.5499565247808, 13362.532311369092, 13364.599062028143, 13423.395947182376, 13461.730765384686, 13463.932680336584, 12689.4924203032, 12719.173253738523, 12763.0, 12824.807627885566, 12848.421821018053, 651.8565915498607, 652.0284775684244, 775.4455564271544, 778.4006315137341, 804.7666176808718, 795.645937557787, 796.5778137587088, 800.2637573432427, 803.2650125135523, 803.2650125135523, 832.7585000349891, 835.9916400835974, 836.9455985360962, 837.7696133563257, 838.2455789789177, 687.6355531568277, 691.5021184747, 823.1233736071065, 837.7905523619095, 840.2437805974611, 615.1203778596605, 615.273976707485, 615.3538784276492, 615.6152404747033, 615.9445649891486, 12902.096853220279, 12977.221366717933, 12977.221366718028, 12992.090553661248, 13020.283884386356, 12740.745185096339, 12994.350282485839, 13028.0, 13235.470581176742, 13261.46954121834, 10185.59257629694, 10214.438205898747, 10248.538815753234, 10835.83746243807, 11074.501647425885, 3608.0077978555846, 3622.5471816022996, 3632.2553876455263, 3640.5085313482605, 3756.286305601954, 42181.789091054656, 42259.36610950838, 42323.788381058206, 42469.0, 43650.563494364964, 9229.630814767468, 9353.0, 9476.384035037701, 9517.762055948519, 9595.90404095964, 15863.762043569355, 15886.76169857453, 15970.281337339848, 17206.225719842638, 17488.562785930455, 6933.7226510939, 6956.930430695729, 7180.1742799578715, 7472.962635186789, 7577.598144343314, 4127.09203975125, 4138.544760076389, 4157.48031496063, 4166.520850102216, 4183.707140500136, 2852.800303978702, 2869.182283049321, 2871.956920646192, 2872.1096460097438, 2887.7112288770954, 499.74762744813637, 512.8743457852776, 517.9818706345335, 532.4329588987794, 532.9973350133303, 559.1808001278147, 600.3156401702063, 610.0, 645.3868824616633, 657.8717150155769, 9096.772580685536, 9158.129977652112, 9187.81624367509, 9205.861912071325, 9412.058794120534, 648.2156590525517, 674.1135406939858, 674.4402146218627, 685.1606781692387, 695.2317688953734, 3729.906752331159, 3786.0, 3872.3223435898603, 3960.2277555876326, 3987.7806720630642, 51222.0, 51847.48152518502, 51856.0, 52161.2175817363, 52235.47764522382, 47015.76492117518, 48054.519454805704, 48741.26888096681, 48888.75555622199, 49029.50970490249, 41555.792221038704, 41614.791926040176, 42386.0, 42557.787211064366, 42644.0, 7591.824496526999, 7608.657610407656, 7861.135275119618, 7907.8813817793925, 7953.9602301990435, 33916.660833391354, 34017.48973765346, 34935.475967859995, 35356.469652954715, 36084.81957590195, 40701.79649101854, 40740.388894167205, 41240.0, 41319.0, 41672.37491437692, 10656.84014739795, 10701.678949631523, 11027.669169924915, 11051.0, 11451.484683189443, 10962.56149754001, 11409.543618255177, 11500.424978750862, 11541.942290288494, 11629.53481860716, 11314.15143864197, 11706.70733231676, 11774.823377649513, 12015.639530814089, 12075.0, 11493.54025838957, 11759.118066144902, 11793.587224447103, 11849.348285844362, 12331.383430828244, 11035.337879727242, 11061.999880270807, 11111.944440277746, 11389.772204555697, 11482.368469734245, 9145.817083658156, 9286.442813431217, 9305.906940930505, 9483.110699379557, 9523.19052880513, 9300.302477314093, 9349.813003739751, 9831.9016809831, 10257.435841028517, 10272.075513203847], "unit": "score", "name": "yui.html", "value": 6098.828110338179}], "name": "dromaeo_css", "value": 6574.977144885179}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 111.0, 113.0, 114.0, 102.0, 115.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [144.0, 131.0, 150.0, 170.0, 128.0, 159.0, 155.0, 128.0, 174.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 158.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 81.0, 106.0, 71.0, 72.0, 72.0, 94.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 139.0, 95.0, 97.0, 97.0, 147.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 55.0, 56.0, 57.0, 58.0, 57.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 69.0, 68.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 88.0, 85.0, 91.0, 93.0, 87.0, 87.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [122.0, 120.0, 118.0, 118.0, 123.0, 126.0, 129.0, 120.0, 117.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 162.0, 155.0, 144.0, 141.0, 153.0, 153.0, 151.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 68.0, 68.0, 69.0, 68.0, 67.0, 70.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1511.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [191.131498470948], "unit": "score", "name": "DeltaBlue", "value": 345.9293760000001}, {"lowerIsBetter": false, "replicates": [280.19052956010086], "unit": "score", "name": "Encrypt", "value": 949.9999890000003}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1102.5358324145534], "unit": "score", "name": "RayTrace", "value": 671.170023}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [42142.857142857145], "unit": "score", "name": "RegExp", "value": 21.616593220338988}, {"lowerIsBetter": false, "replicates": [591.8966529653552], "unit": "score", "name": "Splay", "value": 137.67775099206347}, {"lowerIsBetter": false, "replicates": [4878.048780487805], "unit": "score", "name": "NavierStokes", "value": 304.2200000000002}], "name": "v8_7", "value": 20100.640031296414}]} 14:23:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20100.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6574.98"}}} 14:23:38 INFO - Return code: 0 14:23:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:38 INFO - # TBPL SUCCESS # 14:23:38 INFO - Running post-action listener: _resource_record_post_action 14:23:38 INFO - Running post-run listener: _resource_record_post_run 14:23:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 551124992; Read time: 0; Write time: 507876 14:23:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 239099904; Read time: 0; Write time: 240868 14:23:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 312025088; Read time: 0; Write time: 267008 14:23:39 INFO - Running post-run listener: _upload_blobber_files 14:23:39 INFO - Blob upload gear active. 14:23:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 14:23:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:23:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 14:23:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 14:23:40 INFO - (blobuploader) - INFO - Open directory for files ... 14:23:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 14:23:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:23:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:41 INFO - (blobuploader) - INFO - Done attempting. 14:23:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:23:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:23:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:23:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:23:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:23:41 INFO - (blobuploader) - INFO - Done attempting. 14:23:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:23:41 INFO - Return code: 0 14:23:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 14:23:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 14:23:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b431d9857d5ee247eb10d7d04500d337ecac4ea692cd5a255aa4b0e95e5acb0f3fb20bccfcf096de32822edd98b795a8d20c4627744e3938f89e981615e6eea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e82df5e20fa7246b808dc626643bf6532978f6eb4414e812b94ab005ad4f1f80a76b2df7e5b6f20e7c5d7c99d3e253eeaf111b9b33e3f4ae53af3ad9ba446318"} 14:23:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 14:23:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 14:23:41 INFO - Contents: 14:23:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b431d9857d5ee247eb10d7d04500d337ecac4ea692cd5a255aa4b0e95e5acb0f3fb20bccfcf096de32822edd98b795a8d20c4627744e3938f89e981615e6eea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e82df5e20fa7246b808dc626643bf6532978f6eb4414e812b94ab005ad4f1f80a76b2df7e5b6f20e7c5d7c99d3e253eeaf111b9b33e3f4ae53af3ad9ba446318"} 14:23:41 INFO - Copying logs to upload dir... 14:23:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.466002 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-10 14:23:40.513283) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:40.517246) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 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/b431d9857d5ee247eb10d7d04500d337ecac4ea692cd5a255aa4b0e95e5acb0f3fb20bccfcf096de32822edd98b795a8d20c4627744e3938f89e981615e6eea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e82df5e20fa7246b808dc626643bf6532978f6eb4414e812b94ab005ad4f1f80a76b2df7e5b6f20e7c5d7c99d3e253eeaf111b9b33e3f4ae53af3ad9ba446318"} build_url:https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/H8JIGeHWSIyTiI9Kw1Kfig/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/b431d9857d5ee247eb10d7d04500d337ecac4ea692cd5a255aa4b0e95e5acb0f3fb20bccfcf096de32822edd98b795a8d20c4627744e3938f89e981615e6eea8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e82df5e20fa7246b808dc626643bf6532978f6eb4414e812b94ab005ad4f1f80a76b2df7e5b6f20e7c5d7c99d3e253eeaf111b9b33e3f4ae53af3ad9ba446318"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:40.542815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:40.543178) ========= 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=6d15e502d8e29d5d2676d664000001c3-1452461207.151433-539699644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 14:23:40.630050) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 14:23:40.630643) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 14:23:40.631234) ========= ========= Total master_lag: 0.28 =========