builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1453391498.14 results: success (0) buildid: 20160120073402 builduid: f9f44c436add4a1d8910ad9c9d3d91ad revision: 6764bc656c1d146962d53710d734c2ac87c2306f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.137697) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.138230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.138966) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006291 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.179602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.179909) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.202434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.202705) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.265619) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.265937) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.266318) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.266595) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 07:51:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 30.1M=0s 2016-01-21 07:51:38 (30.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098602 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.378390) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.378739) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021289 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:38.429717) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 07:51:38.430100) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6764bc656c1d146962d53710d734c2ac87c2306f --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6764bc656c1d146962d53710d734c2ac87c2306f --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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 07:51:38,929 truncating revision to first 12 chars 2016-01-21 07:51:38,929 Setting DEBUG logging. 2016-01-21 07:51:38,929 attempt 1/10 2016-01-21 07:51:38,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6764bc656c1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 07:51:39,877 unpacking tar archive at: mozilla-central-6764bc656c1d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.230753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-21 07:51:39.673861) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.674359) ========= echo 6764bc656c1d146962d53710d734c2ac87c2306f in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6764bc656c1d146962d53710d734c2ac87c2306f'] 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6764bc656c1d146962d53710d734c2ac87c2306f program finished with exit code 0 elapsedTime=0.004515 script_repo_revision: '6764bc656c1d146962d53710d734c2ac87c2306f' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.725997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.726325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.736798) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.737247) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/6764bc656c1d146962d53710d734c2ac87c2306f ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:51:39.737714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-21 07:51:39.738051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:40 INFO - MultiFileLogger online at 20160121 07:51:40 in /builds/slave/test-pgo 07:51:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:51:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:51:40 INFO - {'append_to_log': False, 07:51:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:51:40 INFO - 'blob_upload_branch': 'Firefox', 07:51:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:51:40 INFO - 'branch': 'Firefox', 07:51:40 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:40 INFO - 'config_files': ('talos/linux_config.py',), 07:51:40 INFO - 'default_actions': ('clobber', 07:51:40 INFO - 'read-buildbot-config', 07:51:40 INFO - 'download-and-extract', 07:51:40 INFO - 'populate-webroot', 07:51:40 INFO - 'create-virtualenv', 07:51:40 INFO - 'install', 07:51:40 INFO - 'run-tests'), 07:51:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:40 INFO - 'download_minidump_stackwalk': True, 07:51:40 INFO - 'download_symbols': 'ondemand', 07:51:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:40 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:40 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:40 INFO - 'installer_path': 'installer.exe', 07:51:40 INFO - 'log_level': 'info', 07:51:40 INFO - 'log_name': 'talos', 07:51:40 INFO - 'log_to_console': True, 07:51:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:40 INFO - 'opt_config_files': (), 07:51:40 INFO - 'pip_index': False, 07:51:40 INFO - 'sps_profile': False, 07:51:40 INFO - 'sps_profile_interval': 0, 07:51:40 INFO - 'suite': 'dromaeojs', 07:51:40 INFO - 'system_bits': '32', 07:51:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:40 INFO - 'title': 'talos-linux64-ix-063', 07:51:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:40 INFO - 'use_talos_json': True, 07:51:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:51:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:40 INFO - 'work_dir': 'build'} 07:51:40 INFO - ##### 07:51:40 INFO - ##### Running clobber step. 07:51:40 INFO - ##### 07:51:40 INFO - Running pre-action listener: _resource_record_pre_action 07:51:40 INFO - Running main action method: clobber 07:51:40 INFO - rmtree: /builds/slave/test-pgo/build 07:51:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:51:41 INFO - Running post-action listener: _resource_record_post_action 07:51:41 INFO - ##### 07:51:41 INFO - ##### Running read-buildbot-config step. 07:51:41 INFO - ##### 07:51:41 INFO - Running pre-action listener: _resource_record_pre_action 07:51:41 INFO - Running main action method: read_buildbot_config 07:51:41 INFO - Using buildbot properties: 07:51:41 INFO - { 07:51:41 INFO - "project": "", 07:51:41 INFO - "product": "firefox", 07:51:41 INFO - "script_repo_revision": "production", 07:51:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:51:41 INFO - "repository": "", 07:51:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:51:41 INFO - "buildid": "20160120073402", 07:51:41 INFO - "pgo_build": "True", 07:51:41 INFO - "basedir": "/builds/slave/test-pgo", 07:51:41 INFO - "buildnumber": 653, 07:51:41 INFO - "slavename": "talos-linux64-ix-063", 07:51:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:51:41 INFO - "platform": "ubuntu64_hw", 07:51:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:51:41 INFO - "branch": "mozilla-central", 07:51:41 INFO - "repo_path": "mozilla-central", 07:51:41 INFO - "revision": "6764bc656c1d146962d53710d734c2ac87c2306f", 07:51:41 INFO - "stage_platform": "linux64-pgo", 07:51:41 INFO - "builduid": "f9f44c436add4a1d8910ad9c9d3d91ad", 07:51:41 INFO - "slavebuilddir": "test" 07:51:41 INFO - } 07:51:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:51:41 INFO - Running post-action listener: _resource_record_post_action 07:51:41 INFO - ##### 07:51:41 INFO - ##### Running download-and-extract step. 07:51:41 INFO - ##### 07:51:41 INFO - Running pre-action listener: _resource_record_pre_action 07:51:41 INFO - Running main action method: download_and_extract 07:51:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:51:41 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')]} 07:51:41 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json 07:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:51:42 INFO - Downloaded 1448 bytes. 07:51:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:51:42 INFO - Using the following test package requirements: 07:51:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:42 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'jsshell-linux-x86_64.zip'], 07:51:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:42 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')]} 07:51:42 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:44 INFO - Downloaded 22485896 bytes. 07:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:45 INFO - Return code: 0 07:51:45 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 07:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:45 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:47 INFO - Downloaded 22485896 bytes. 07:51:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:48 INFO - Return code: 0 07:51: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')]} 07:51:48 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:49 INFO - Downloaded 11132144 bytes. 07:51:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:51:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:51:49 INFO - Return code: 0 07:51: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')]} 07:51:49 INFO - https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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 07:51:51 INFO - Downloaded 55941556 bytes. 07:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:51 INFO - mkdir: /builds/slave/test-pgo/properties 07:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:51:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:51:51 INFO - Contents: 07:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:51:51 INFO - Running post-action listener: _resource_record_post_action 07:51:51 INFO - Running post-action listener: set_extra_try_arguments 07:51:51 INFO - ##### 07:51:51 INFO - ##### Running populate-webroot step. 07:51:51 INFO - ##### 07:51:51 INFO - Running pre-action listener: _resource_record_pre_action 07:51:51 INFO - Running main action method: populate_webroot 07:51:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:51 INFO - '--tppagecycles', 07:51:51 INFO - '7'], 07:51:51 INFO - 'tests': ['tsvgm']}}, 07:51:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:51:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:51:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:51:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'tests': ['damp', 'tps']}, 07:51:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['damp', 'tps']}, 07:51:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:51:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:51 INFO - 'other': {'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'other_l64': {'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'other_nol64': {'tests': ['a11yr', 07:51:51 INFO - 'ts_paint', 07:51:51 INFO - 'tpaint', 07:51:51 INFO - 'sessionrestore', 07:51:51 INFO - 'sessionrestore_no_auto_restore']}, 07:51:51 INFO - 'svgr': {'tests': ['tsvgx', 07:51:51 INFO - 'tsvgr_opacity', 07:51:51 INFO - 'tart', 07:51:51 INFO - 'tscrollx', 07:51:51 INFO - 'cart']}, 07:51:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['tsvgx', 07:51:51 INFO - 'tsvgr_opacity', 07:51:51 INFO - 'tart', 07:51:51 INFO - 'tscrollx', 07:51:51 INFO - 'cart']}, 07:51:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'tests': ['tp5o']}, 07:51:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'talos_options': ['--e10s'], 07:51:51 INFO - 'tests': ['tp5o']}, 07:51:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'talos_options': ['--xperf_path', 07:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:51 INFO - 'tests': ['tp5n']}, 07:51:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:51 INFO - 'talos_options': ['--e10s', 07:51:51 INFO - '--xperf_path', 07:51:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:51 INFO - 'tests': ['tp5n']}}, 07:51:51 INFO - 'talos.zip': {'path': '', 07:51:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:51 INFO - Running post-action listener: _resource_record_post_action 07:51:51 INFO - ##### 07:51:51 INFO - ##### Running create-virtualenv step. 07:51:51 INFO - ##### 07:51:51 INFO - Running pre-action listener: _resource_record_pre_action 07:51:51 INFO - Running main action method: create_virtualenv 07:51:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:51:51 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 07:51:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:51:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:51 INFO - Using real prefix '/usr' 07:51:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:51:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:54 INFO - Installing pip.................done. 07:51:54 INFO - Return code: 0 07:51:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:51:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:51:54 INFO - Using env: {'DISPLAY': ':0', 07:51:54 INFO - 'HOME': '/home/cltbld', 07:51:54 INFO - 'LANG': 'en_US.UTF-8', 07:51:54 INFO - 'LANGUAGE': 'en_US:en', 07:51:54 INFO - 'LOGNAME': 'cltbld', 07:51:54 INFO - 'MAIL': '/var/mail/cltbld', 07:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:54 INFO - 'MOZ_NO_REMOTE': '1', 07:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:54 INFO - 'NO_EM_RESTART': '1', 07:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:54 INFO - 'SHELL': '/bin/bash', 07:51:54 INFO - 'SHLVL': '1', 07:51:54 INFO - 'TERM': 'linux', 07:51:54 INFO - 'TMOUT': '86400', 07:51:54 INFO - 'USER': 'cltbld', 07:51:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:54 INFO - '_': '/tools/buildbot/bin/python'} 07:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:54 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 07:51:54 INFO - Cleaning up... 07:51:54 INFO - Return code: 0 07:51:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:51:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:51:54 INFO - Using env: {'DISPLAY': ':0', 07:51:54 INFO - 'HOME': '/home/cltbld', 07:51:54 INFO - 'LANG': 'en_US.UTF-8', 07:51:54 INFO - 'LANGUAGE': 'en_US:en', 07:51:54 INFO - 'LOGNAME': 'cltbld', 07:51:54 INFO - 'MAIL': '/var/mail/cltbld', 07:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:54 INFO - 'MOZ_NO_REMOTE': '1', 07:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:54 INFO - 'NO_EM_RESTART': '1', 07:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:54 INFO - 'SHELL': '/bin/bash', 07:51:54 INFO - 'SHLVL': '1', 07:51:54 INFO - 'TERM': 'linux', 07:51:54 INFO - 'TMOUT': '86400', 07:51:54 INFO - 'USER': 'cltbld', 07:51:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:54 INFO - '_': '/tools/buildbot/bin/python'} 07:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:54 INFO - Downloading/unpacking psutil>=0.7.1 07:51:54 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 07:51:54 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 07:51:54 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 07:51:54 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 07:51:54 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 07:51:54 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 07:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:56 INFO - Installing collected packages: psutil 07:51:56 INFO - Running setup.py install for psutil 07:51:56 INFO - building 'psutil._psutil_linux' extension 07:51:56 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 07:51:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:51:56 INFO - building 'psutil._psutil_posix' extension 07:51:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:51:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:57 INFO - Successfully installed psutil 07:51:57 INFO - Cleaning up... 07:51:57 INFO - Return code: 0 07:51:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:51:57 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')]} 07:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:57 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')]} 07:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:51:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:51:57 INFO - Using env: {'DISPLAY': ':0', 07:51:57 INFO - 'HOME': '/home/cltbld', 07:51:57 INFO - 'LANG': 'en_US.UTF-8', 07:51:57 INFO - 'LANGUAGE': 'en_US:en', 07:51:57 INFO - 'LOGNAME': 'cltbld', 07:51:57 INFO - 'MAIL': '/var/mail/cltbld', 07:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:57 INFO - 'MOZ_NO_REMOTE': '1', 07:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:57 INFO - 'NO_EM_RESTART': '1', 07:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:57 INFO - 'SHELL': '/bin/bash', 07:51:57 INFO - 'SHLVL': '1', 07:51:57 INFO - 'TERM': 'linux', 07:51:57 INFO - 'TMOUT': '86400', 07:51:57 INFO - 'USER': 'cltbld', 07:51:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:57 INFO - '_': '/tools/buildbot/bin/python'} 07:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:51:57 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 07:51:57 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 07:51:57 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 07:51:57 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 07:51:57 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 07:51:57 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 07:51:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:51:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:51:59 INFO - Installing collected packages: mozsystemmonitor 07:51:59 INFO - Running setup.py install for mozsystemmonitor 07:51:59 INFO - Successfully installed mozsystemmonitor 07:51:59 INFO - Cleaning up... 07:51:59 INFO - Return code: 0 07:51:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:51:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:51:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:51:59 INFO - Using env: {'DISPLAY': ':0', 07:51:59 INFO - 'HOME': '/home/cltbld', 07:51:59 INFO - 'LANG': 'en_US.UTF-8', 07:51:59 INFO - 'LANGUAGE': 'en_US:en', 07:51:59 INFO - 'LOGNAME': 'cltbld', 07:51:59 INFO - 'MAIL': '/var/mail/cltbld', 07:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:59 INFO - 'MOZ_NO_REMOTE': '1', 07:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:59 INFO - 'NO_EM_RESTART': '1', 07:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:51:59 INFO - 'SHELL': '/bin/bash', 07:51:59 INFO - 'SHLVL': '1', 07:51:59 INFO - 'TERM': 'linux', 07:51:59 INFO - 'TMOUT': '86400', 07:51:59 INFO - 'USER': 'cltbld', 07:51:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:59 INFO - '_': '/tools/buildbot/bin/python'} 07:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:59 INFO - Downloading/unpacking blobuploader==1.2.4 07:51:59 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 07:51:59 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 07:51:59 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 07:51:59 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 07:51:59 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 07:51:59 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 07:52:01 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:52:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52: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 07:52:02 INFO - Downloading docopt-0.6.1.tar.gz 07:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:02 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:02 INFO - Running setup.py install for blobuploader 07:52:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:52:02 INFO - Running setup.py install for requests 07:52:02 INFO - Running setup.py install for docopt 07:52:02 INFO - Successfully installed blobuploader requests docopt 07:52:02 INFO - Cleaning up... 07:52:02 INFO - Return code: 0 07:52:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52:02 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')]} 07:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:02 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')]} 07:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:52:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:52:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:02 INFO - Using env: {'DISPLAY': ':0', 07:52:02 INFO - 'HOME': '/home/cltbld', 07:52:02 INFO - 'LANG': 'en_US.UTF-8', 07:52:02 INFO - 'LANGUAGE': 'en_US:en', 07:52:02 INFO - 'LOGNAME': 'cltbld', 07:52:02 INFO - 'MAIL': '/var/mail/cltbld', 07:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:02 INFO - 'MOZ_NO_REMOTE': '1', 07:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:02 INFO - 'NO_EM_RESTART': '1', 07:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:02 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:02 INFO - 'SHELL': '/bin/bash', 07:52:02 INFO - 'SHLVL': '1', 07:52:02 INFO - 'TERM': 'linux', 07:52:02 INFO - 'TMOUT': '86400', 07:52:02 INFO - 'USER': 'cltbld', 07:52:02 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:02 INFO - '_': '/tools/buildbot/bin/python'} 07:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:02 INFO - Running setup.py (path:/tmp/pip-EbmJDq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:02 INFO - Running setup.py (path:/tmp/pip-mR7AQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:03 INFO - Running setup.py (path:/tmp/pip-OSyxNW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:03 INFO - Running setup.py (path:/tmp/pip-YxWa6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:03 INFO - Running setup.py (path:/tmp/pip-R_ZQ9g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:03 INFO - Running setup.py (path:/tmp/pip-PTpeEQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:03 INFO - Running setup.py (path:/tmp/pip-QCNKBD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:03 INFO - Running setup.py (path:/tmp/pip-ZwnKKW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:03 INFO - Running setup.py (path:/tmp/pip-AmsMEQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:03 INFO - Running setup.py (path:/tmp/pip-_TR_S5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:03 INFO - Running setup.py (path:/tmp/pip-k5b20y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:03 INFO - Running setup.py (path:/tmp/pip-tLNXA3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:03 INFO - Running setup.py (path:/tmp/pip-QuF_tx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:03 INFO - Running setup.py (path:/tmp/pip-CTXdgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:03 INFO - Running setup.py (path:/tmp/pip-hFQVpR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:03 INFO - Running setup.py (path:/tmp/pip-dFYSjM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:04 INFO - Running setup.py (path:/tmp/pip-mEARQq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:04 INFO - Running setup.py install for manifestparser 07:52:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozcrash 07:52:04 INFO - Running setup.py install for mozdebug 07:52:04 INFO - Running setup.py install for mozdevice 07:52:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozfile 07:52:04 INFO - Running setup.py install for mozhttpd 07:52:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozinfo 07:52:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozInstall 07:52:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:52:04 INFO - Running setup.py install for mozleak 07:52:05 INFO - Running setup.py install for mozlog 07:52:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Running setup.py install for moznetwork 07:52:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Running setup.py install for mozprocess 07:52:05 INFO - Running setup.py install for mozprofile 07:52:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Running setup.py install for mozrunner 07:52:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Running setup.py install for mozscreenshot 07:52:05 INFO - Running setup.py install for moztest 07:52:05 INFO - Running setup.py install for mozversion 07:52:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:52:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:05 INFO - Cleaning up... 07:52:05 INFO - Return code: 0 07:52:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:52:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:05 INFO - Using env: {'DISPLAY': ':0', 07:52:05 INFO - 'HOME': '/home/cltbld', 07:52:05 INFO - 'LANG': 'en_US.UTF-8', 07:52:05 INFO - 'LANGUAGE': 'en_US:en', 07:52:05 INFO - 'LOGNAME': 'cltbld', 07:52:05 INFO - 'MAIL': '/var/mail/cltbld', 07:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:05 INFO - 'MOZ_NO_REMOTE': '1', 07:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:05 INFO - 'NO_EM_RESTART': '1', 07:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:05 INFO - 'SHELL': '/bin/bash', 07:52:05 INFO - 'SHLVL': '1', 07:52:05 INFO - 'TERM': 'linux', 07:52:05 INFO - 'TMOUT': '86400', 07:52:05 INFO - 'USER': 'cltbld', 07:52:05 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:05 INFO - '_': '/tools/buildbot/bin/python'} 07:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:06 INFO - Running setup.py (path:/tmp/pip-DiilN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:06 INFO - Running setup.py (path:/tmp/pip-ikxFQH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:06 INFO - Running setup.py (path:/tmp/pip-qM6U_V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:06 INFO - Running setup.py (path:/tmp/pip-2qOl1F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:52:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:06 INFO - Running setup.py (path:/tmp/pip-lXU_lh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:06 INFO - Running setup.py (path:/tmp/pip-dRzasL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:06 INFO - Running setup.py (path:/tmp/pip-47erP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:06 INFO - Running setup.py (path:/tmp/pip-fGHAi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:06 INFO - Running setup.py (path:/tmp/pip-aFWHEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:06 INFO - Running setup.py (path:/tmp/pip-__y9o4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:06 INFO - Running setup.py (path:/tmp/pip-xufdkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:52:06 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)) 07:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:06 INFO - Running setup.py (path:/tmp/pip-al_2__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 07:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:07 INFO - Running setup.py (path:/tmp/pip-9AhTle-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:07 INFO - Running setup.py (path:/tmp/pip-8hopZW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 07:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:07 INFO - Running setup.py (path:/tmp/pip-UtwJHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:52:07 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)) 07:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:07 INFO - Running setup.py (path:/tmp/pip-UYdmen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:52:07 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)) 07:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:07 INFO - Running setup.py (path:/tmp/pip-ZlUk2g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:52:07 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)) 07:52:07 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)) 07:52:07 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)) 07:52:07 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)) 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:52:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:07 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 07:52:07 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 07:52:07 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 07:52:07 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 07:52:07 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 07:52:07 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 07:52:09 INFO - Downloading blessings-1.6.tar.gz 07:52:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:09 INFO - Installing collected packages: blessings 07:52:09 INFO - Running setup.py install for blessings 07:52:09 INFO - Successfully installed blessings 07:52:09 INFO - Cleaning up... 07:52:09 INFO - Return code: 0 07:52:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:52:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:09 INFO - Reading from file tmpfile_stdout 07:52:09 INFO - Current package versions: 07:52:09 INFO - argparse == 1.2.1 07:52:09 INFO - blessings == 1.6 07:52:09 INFO - blobuploader == 1.2.4 07:52:09 INFO - docopt == 0.6.1 07:52:09 INFO - manifestparser == 1.1 07:52:09 INFO - mozInstall == 1.12 07:52:09 INFO - mozcrash == 0.16 07:52:09 INFO - mozdebug == 0.1 07:52:09 INFO - mozdevice == 0.48 07:52:09 INFO - mozfile == 1.2 07:52:09 INFO - mozhttpd == 0.7 07:52:09 INFO - mozinfo == 0.9 07:52:09 INFO - mozleak == 0.1 07:52:09 INFO - mozlog == 3.1 07:52:09 INFO - moznetwork == 0.27 07:52:09 INFO - mozprocess == 0.22 07:52:09 INFO - mozprofile == 0.28 07:52:09 INFO - mozrunner == 6.11 07:52:09 INFO - mozscreenshot == 0.1 07:52:09 INFO - mozsystemmonitor == 0.0 07:52:09 INFO - moztest == 0.7 07:52:09 INFO - mozversion == 1.4 07:52:09 INFO - psutil == 3.1.1 07:52:09 INFO - requests == 1.2.3 07:52:09 INFO - wsgiref == 0.1.2 07:52:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:52:09 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')]} 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 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')]} 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:52:09 INFO - Using env: {'DISPLAY': ':0', 07:52:09 INFO - 'HOME': '/home/cltbld', 07:52:09 INFO - 'LANG': 'en_US.UTF-8', 07:52:09 INFO - 'LANGUAGE': 'en_US:en', 07:52:09 INFO - 'LOGNAME': 'cltbld', 07:52:09 INFO - 'MAIL': '/var/mail/cltbld', 07:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:09 INFO - 'MOZ_NO_REMOTE': '1', 07:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:09 INFO - 'NO_EM_RESTART': '1', 07:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:09 INFO - 'SHELL': '/bin/bash', 07:52:09 INFO - 'SHLVL': '1', 07:52:09 INFO - 'TERM': 'linux', 07:52:09 INFO - 'TMOUT': '86400', 07:52:09 INFO - 'USER': 'cltbld', 07:52:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:09 INFO - '_': '/tools/buildbot/bin/python'} 07:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 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)) 07:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 07:52:09 INFO - Cleaning up... 07:52:09 INFO - Return code: 0 07:52:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:52:09 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')]} 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 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')]} 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:52:09 INFO - Using env: {'DISPLAY': ':0', 07:52:09 INFO - 'HOME': '/home/cltbld', 07:52:09 INFO - 'LANG': 'en_US.UTF-8', 07:52:09 INFO - 'LANGUAGE': 'en_US:en', 07:52:09 INFO - 'LOGNAME': 'cltbld', 07:52:09 INFO - 'MAIL': '/var/mail/cltbld', 07:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:09 INFO - 'MOZ_NO_REMOTE': '1', 07:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:09 INFO - 'NO_EM_RESTART': '1', 07:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:09 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:09 INFO - 'SHELL': '/bin/bash', 07:52:09 INFO - 'SHLVL': '1', 07:52:09 INFO - 'TERM': 'linux', 07:52:09 INFO - 'TMOUT': '86400', 07:52:09 INFO - 'USER': 'cltbld', 07:52:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:09 INFO - '_': '/tools/buildbot/bin/python'} 07:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:10 INFO - Downloading/unpacking jsonschema 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:52:11 INFO - Downloading/unpacking functools32 (from jsonschema) 07:52:11 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 07:52:11 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 07:52:11 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 07:52:11 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 07:52:11 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 07:52:11 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 07:52:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:52:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:52:12 INFO - warning: no files found matching '*.txt' 07:52:12 INFO - no previously-included directories found matching 'build' 07:52:12 INFO - no previously-included directories found matching 'dist' 07:52:12 INFO - no previously-included directories found matching '.git*' 07:52:12 INFO - Installing collected packages: jsonschema, functools32 07:52:12 INFO - Running setup.py install for functools32 07:52:12 INFO - warning: no files found matching '*.txt' 07:52:12 INFO - no previously-included directories found matching 'build' 07:52:12 INFO - no previously-included directories found matching 'dist' 07:52:12 INFO - no previously-included directories found matching '.git*' 07:52:12 INFO - Successfully installed jsonschema functools32 07:52:12 INFO - Cleaning up... 07:52:12 INFO - Return code: 0 07:52:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6cdf8bcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2567630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, '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': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', '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 07:52:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:52:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:52:12 INFO - Using env: {'DISPLAY': ':0', 07:52:12 INFO - 'HOME': '/home/cltbld', 07:52:12 INFO - 'LANG': 'en_US.UTF-8', 07:52:12 INFO - 'LANGUAGE': 'en_US:en', 07:52:12 INFO - 'LOGNAME': 'cltbld', 07:52:12 INFO - 'MAIL': '/var/mail/cltbld', 07:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:12 INFO - 'MOZ_NO_REMOTE': '1', 07:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:12 INFO - 'NO_EM_RESTART': '1', 07:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:12 INFO - 'SHELL': '/bin/bash', 07:52:12 INFO - 'SHLVL': '1', 07:52:12 INFO - 'TERM': 'linux', 07:52:12 INFO - 'TMOUT': '86400', 07:52:12 INFO - 'USER': 'cltbld', 07:52:12 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:12 INFO - '_': '/tools/buildbot/bin/python'} 07:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:12 INFO - Downloading/unpacking flake8 07:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:14 INFO - no previously-included directories found matching 'docs/_build' 07:52:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:15 INFO - Running setup.py install for pep8 07:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:15 INFO - no previously-included directories found matching 'docs/_build' 07:52:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:52:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:15 INFO - Cleaning up... 07:52:15 INFO - Return code: 0 07:52:15 INFO - Running post-action listener: _resource_record_post_action 07:52:15 INFO - Running post-action listener: _start_resource_monitoring 07:52:15 INFO - Starting resource monitoring. 07:52:15 INFO - ##### 07:52:15 INFO - ##### Running install step. 07:52:15 INFO - ##### 07:52:15 INFO - Running pre-action listener: _resource_record_pre_action 07:52:15 INFO - Running main action method: install 07:52:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:52:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:52:15 INFO - Reading from file tmpfile_stdout 07:52:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:52:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:52:15 INFO - Reading from file tmpfile_stdout 07:52:15 INFO - Output received: 07:52:15 INFO - Usage: mozinstall [options] installer 07:52:15 INFO - Options: 07:52:15 INFO - -h, --help show this help message and exit 07:52:15 INFO - -d DEST, --destination=DEST 07:52:15 INFO - Directory to install application into. [default: 07:52:15 INFO - "/builds/slave/test-pgo"] 07:52:15 INFO - --app=APP Application being installed. [default: firefox] 07:52:15 INFO - mkdir: /builds/slave/test-pgo/build/application 07:52:15 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'] 07:52:15 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 07:52:31 INFO - Reading from file tmpfile_stdout 07:52:31 INFO - Output received: 07:52:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:52:31 INFO - Running post-action listener: _resource_record_post_action 07:52:31 INFO - ##### 07:52:31 INFO - ##### Running run-tests step. 07:52:31 INFO - ##### 07:52:31 INFO - Running pre-action listener: _resource_record_pre_action 07:52:31 INFO - Running main action method: run_tests 07:52:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:52:31 INFO - Python 2.7.3 07:52:31 INFO - Return code: 0 07:52:31 INFO - grabbing minidump binary from tooltool 07:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25f8840>, '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 0x25656b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2565b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:52:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:52:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:52:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:31 INFO - Return code: 0 07:52:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:52:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:52:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:52:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:52:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:52:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:52:32 INFO - Return code: 0 07:52:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:52:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 07:52:32 INFO - Using env: {'DISPLAY': ':0', 07:52:32 INFO - 'HOME': '/home/cltbld', 07:52:32 INFO - 'LANG': 'en_US.UTF-8', 07:52:32 INFO - 'LANGUAGE': 'en_US:en', 07:52:32 INFO - 'LOGNAME': 'cltbld', 07:52:32 INFO - 'MAIL': '/var/mail/cltbld', 07:52:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:32 INFO - 'MOZ_NO_REMOTE': '1', 07:52:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:32 INFO - 'NO_EM_RESTART': '1', 07:52:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:52:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:52:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:52:32 INFO - 'SHELL': '/bin/bash', 07:52:32 INFO - 'SHLVL': '1', 07:52:32 INFO - 'TERM': 'linux', 07:52:32 INFO - 'TMOUT': '86400', 07:52:32 INFO - 'USER': 'cltbld', 07:52:32 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662', 07:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:32 INFO - '_': '/tools/buildbot/bin/python'} 07:52:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 07:52:33 INFO - mozversion application_buildid: 20160120073402 07:52:33 INFO - mozversion application_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:33 INFO - mozversion application_display_name: Nightly 07:52:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:33 INFO - mozversion application_name: Firefox 07:52:33 INFO - mozversion application_remotingname: firefox 07:52:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:33 INFO - mozversion application_vendor: Mozilla 07:52:33 INFO - mozversion application_version: 46.0a1 07:52:33 INFO - mozversion platform_buildid: 20160120073402 07:52:33 INFO - mozversion platform_changeset: 6764bc656c1d146962d53710d734c2ac87c2306f 07:52:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:33 INFO - mozversion platform_version: 46.0a1 07:52:33 INFO - using testdate: 1453391553 07:52:33 INFO - actual date: 1453391553 07:52:33 INFO - starting webserver on 'localhost:35192' 07:52:33 INFO - SUITE-START | Running 3 tests 07:52:33 INFO - TEST-START | dromaeo_css 07:52:33 INFO - operating with platform_type : linux_ 07:52:33 INFO - Initialising browser for dromaeo_css test... 07:52:33 INFO - TEST-INFO | started process 23696 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUNG0NW/profile http://localhost:35192/getInfo.html) 07:52:37 INFO - PROCESS | 23696 | __metrics Screen width/height:1600/1200 07:52:37 INFO - PROCESS | 23696 | colorDepth:24 07:52:37 INFO - PROCESS | 23696 | Browser inner width/height: 1024/697 07:52:37 INFO - PROCESS | 23696 | __metrics 07:52:37 INFO - PROCESS | 23696 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:52:37 INFO - PROCESS | 23696 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:52:37 INFO - TEST-INFO | 23696: exit 0 07:52:37 INFO - Browser initialized. 07:52:37 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:37 INFO - TEST-INFO | started process 23789 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUNG0NW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:49 INFO - PROCESS | 23789 | RSS: Main: 148709376 07:52:49 INFO - PROCESS | 23789 | 07:53:41 INFO - PROCESS | 23789 | 1453391621342 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] 07:55:49 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35192/tests/dromaeo/cssquery-ext.html) 07:55:50 INFO - PROCESS | 23789 | RSS: Main: 229195776 07:55:50 INFO - PROCESS | 23789 | 07:58:52 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-ext.html (next: http://localhost:35192/tests/dromaeo/cssquery-jquery.html) 07:58:53 INFO - PROCESS | 23789 | RSS: Main: 224010240 07:58:53 INFO - PROCESS | 23789 | 08:01:55 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35192/tests/dromaeo/cssquery-mootools.html) 08:01:55 INFO - PROCESS | 23789 | RSS: Main: 237047808 08:01:55 INFO - PROCESS | 23789 | 08:04:57 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35192/tests/dromaeo/cssquery-prototype.html) 08:04:58 INFO - PROCESS | 23789 | RSS: Main: 208588800 08:04:58 INFO - PROCESS | 23789 | 08:08:00 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35192/tests/dromaeo/cssquery-yui.html) 08:08:01 INFO - PROCESS | 23789 | RSS: Main: 215527424 08:08:01 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | Cycle 1(1): loaded http://localhost:35192/tests/dromaeo/cssquery-yui.html (next: http://localhost:35192/tests/dromaeo/cssquery-dojo.html) 08:11:04 INFO - PROCESS | 23789 | RSS: Main: 251736064 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | __start_tp_report 08:11:04 INFO - PROCESS | 23789 | _x_x_mozilla_page_load 08:11:04 INFO - PROCESS | 23789 | _x_x_mozilla_page_load_details 08:11:04 INFO - PROCESS | 23789 | |i|pagename|runs| 08:11:04 INFO - PROCESS | 23789 | |0;dojo.html;3106.9844650776745;3125.5780469636593;3169.065125787892;3175;3202.3755367703293;5088.414832294287;5155.329807125077;5220.32135822343;5237.8952420951555;5242.842714718559;5098.031374038939;5118.232265160228;5239.449857764937;5292.285541451903;5299.735013249341;4755.476897541276;4802.03959208158;4814.422269327685;4880.097182021337;4913.31213630092;4732.100900828848;4856.198727210024;4867.9269810952865;4904.0191961607825;4920.950790492103;4731.929021064687;4822.059698358787;4845.152098382804;4917.114919314522;4919;4746.952530474686;4813.831515896962;4814.807407703687;4827.058723548909;4858.78135483904;4749.1926372516755;4753.78607962639;4761.285807128924;4764.428268607755;4768.356271903318;5003.149464591028;5004.249362595603;5042.3949126104735;5077.847664570068;5082.593392528589;5660.632058916157;5661.7735290588325;5663.7168141593165;5669.546436285087;5673.489385955284;5670.518005969498;5671.801486947937;5683.090705487143;5683.5169010634145;5683.829485115453;5175.275461435402;5247.553957913582;5250.6324557281005;5292.470752924677;5357.357117145967;5778.248827652378;5784.1902133701315;5787.594868359259;5804.4195580442465;5842.474177324061;5545.833624991256;5555.555555555546;5562.7774889004795;5567.053600887859;5568.805091821767;5541.750621222055;5601.719914004365;5619.185218143346;5630.746616402272;5705.1727499512335;5608.803691870847;5609.046462101371;5611.382747897728;5612.747426365823;5630.831075067755;5484.478974497416;5569.498745112959;5620.072688006433;5620.718964051781;5639.492445679908;4369.2790689536505;4372;4391.604755572014;4404.339349097661;4451.955480445219;3873.4189871518934;3875.9806200968815;3888.066863952631;3910.1006768443417;3921.7254792164845;5066.493350664904;5149.922751158736;5170.715610641376;5181.248718935733;5208.218767184952;5578.497935185853;5612.102063669875;5614.045612245928;5637.295338082739;5663.065594176997;5150.562202212854;5169.741512924339;5169.767360468788;5170.6122040847085;5207.010667973073;4713.363695901009;4786.090642777861;4793.760311984387;4811.639127065484;4814.181589129857;5848.4151584841175;5849.707514624251;5862.267216597926;5873.794417195378;5882.529397648178;5590.049691552527;5593.860153496195;5599.496045355938;5603.131514615241;5610.7194640268635;5626.88746225065;5758.798442054508;5799.971000144972;5836.299644042742;5944.048952167633;5530.972345138249;5536.529395001309;5545.140503222007;5548.306461692288;5548.611597188158;5570.080936645408;5621.775128994958;5622.437756224344;5628.85927851807;5630.943690563206;5422;5497.780088796403;5510.614257002132;5579.051561234681;5587.273654424899;5480.945190548044;5532.2254884317035;5539.058360078877;5541.335039795089;5543.057680194457;5450.836474905759;5453.236546883519;5464.3442786865835;5465.480779325958;5507.173923911445;5441.374241962067;5486.067368547277;5531.0873705839695;5556.333240011225;5595.216669666169;5401.6218864679095;5401.756920938646;5406.107992181246;5407.83776486706;5452.482014208644 08:11:04 INFO - PROCESS | 23789 | |1;ext.html;536.9624126311157;540.6053580885953;549.9797874941985;564.1932037186823;576.5963825322273;27543.035993740225;28076.15771526855;34467.482987755204;35208.295834083365;35284.64715352846;38229.426558601575;38702.22595548088;38724.80637596808;38742;38783.61216387835;8353.122922093184;8500.404971651957;8582.313414926792;8588.441751286146;8596.140385961417;8332.750017499484;8432.325413966868;8445.746627601182;8473.661053557851;8474.576271186446;8592.699255526059;8655.610497527627;8669.95665021674;8672.479651220916;8681.913180868205;8540.316774658013;8610.397272190949;8621.094785047606;8625.611847466847;8626.094260102693;8506.532140732257;8604;8654.740357789276;8664.133586641348;8667.30661547081;38810;39175.8041209795;39229;39261.21477570433;39263.21473570513;3203.2952750394875;3242.1084201844446;3549.2014296783277;3800.923981520382;3917.1773927475265;27360.58959115615;27563.72436275652;29253.41493170146;29389.412211755858;30650;3815.656590906804;3883.7764655336005;3926.312895243321;4056.9249148975546;4058.6955978301744;243865;244887;264482.9999999981;264968;265100;52300.476995230325;52489;52573.211401829;52576.73711631417;52659;56704.71647641735;56838.7158064207;56979.715101425056;57050;57070.143947840814;14027.71944561103;14276.14343139415;14356.497522586867;14365.497207597684;14400.567982960529;10944.726381840517;10973.945130274298;10985.231033827555;10992;10994.95547922962;17789;17849.286028558712;18011.72982405265;18013.369532066314;18028.459146225636;6594.86810263792;7030.437564994891;7135.536190147727;7139.571625702474;7200.423966082701;893.9374243802871;1009.5103874620803;1065.8488832061355;1086.9076128529005;1101.8071837428417;27820.304492387448;29885.850570747007;29916.70083299139;30396;30412;911.1526280559144;984.4437892590663;992.5313008190286;1013.761765984993;1031.3244824639723;12699.682507937376;13177.209367437792;13211.273379964194;13238.867611323956;13301.26843023643;312091;323256;328315;328635;329534;38671.22657546833;48012.279815802794;49487;49582.50417495851;49620.25569616459;1298.2794549025193;1308.8036794480904;1313.90802643814;1316.6181807275975;1320.9669758255927;24008.811670479492;25162.37094072663;26445.206643800717;28957.276068098465;29293.414131717673;43531;44794.3280850794;44802.55197447984;44806.55193448024;44832.551674482835;256773;259006;259158;259252;259320;30956.845215773777;31580.684193157773;31658.36683266368;31667.84166079155;31698.841505792323;39785.60214397935;40727.79636101919;41152.38271425871;41211.1757764849;42615.786921066436;31526.842365788023;31851.522227167075;32635.34729305353;32685.836570816995;33591.496127558596;31078.37843243077;31498.37003259968;31771.364572707953;31992.68007319897;32090;31920;34937.8253108743;35472.82263588665;35765.82117089398;35842.28315433729;27370.863145684143;29135;29919.700802992564;30748.929710637447;31841;22219.333419997427;22305;22412.66381004319;22475;22614.547709045397 08:11:04 INFO - PROCESS | 23789 | |2;jquery.html;365.4737178463013;367.78484586516885;367.8565359509791;368.2947156195883;373.17528262539787;13188.802167967488;13295.468181272738;15636.140012299318;16919.49241522753;17924.462266132003;15118.092914425142;15463.69072618547;15530.37878484862;15606.765898511532;16474.83525164748;5282.656627319221;5448.318960129984;5450.427705090968;5450.945490545084;5473.67157970521;3931;4084.366923126905;5374.677519348832;5402.9729851350885;5786.884262314751;5688.288963879515;5885.617434866741;5940.3762604926505;5948.375420580842;5953.672548009858;5853.268341457318;5854.824355269348;5874.530037597004;5878.911816322759;5908.172855800191;4783.665143439961;4930.260460930853;4951.529604687549;5163.432022477525;5177.741112944375;11730.589429369931;11808.46861891217;13378.665533361647;18984.810151898444;19088.618227635507;2017.9495512612154;2071.637463443891;2081.0400219161766;2115.132795553831;2135.7543882453406;8634.870476942851;8820.603072861737;9055.864162037575;9322.36858549751;12448.190867593577;1708.4020592792547;1805.3230038735473;1827.7532533107992;1828.8536917046604;1841.1530695879912;48371.758141209066;49260.99999999964;49461.50538494641;50051.49948500505;50810.7459462704;8991.325650576233;9059.501727404924;9192.724218273463;9254.074592540826;9356.111169438893;12273.140880138304;12291.586467556166;12298.262104273772;12311;12362.072844536695;6794.660266986631;7055.753048643375;7118.537295075804;7128.394086502602;7199.640017999079;6892.758753443605;6952.200496942916;6980.476464265201;6999.650017499104;7026.543274687129;4045.696572757055;4163.812628431728;4261.424707664488;4280.871573852789;4314.482262128565;1583.5249425172633;1592.9203539823195;1636.6726654669114;1672.874534409924;1688.1346112545705;828.9886338666817;853.9146085391411;882.6734108379812;947.8056998315329;998.7602975286025;14702.411903523953;15319;15411;15622.76565851513;15690.68618627621;856.7729551668813;909.5543183840003;924.2236521322121;925.2459245714721;930.8464103422995;9213.355065145375;9314.95342523283;9410.811783764424;9433.103855133888;9471.668491602899;345260;517126;523754;540037;547231;52813.47186528162;68730.3126968724;69821.30178698148;70037;72021;1048.758785479344;1058.8305871060593;1077.52050337599;1079.1312993040522;1081.810683130449;14031.579052628438;14566.927165364104;14837.92581037088;15095.169765662993;15124.697506049597;29805.254868628457;30660.386792264475;30911.2272193197;30926;31122.68877311198;36785.448218276215;37391.439128413636;37635;38994;40880.79559602302;7061.470389720689;7216.7834964951135;7222.422206223595;7382.52013619113;7421.591812450367;8492.447990880573;8929.821403572023;10822.621208257673;11227.71930701739;11438.94280528592;9101.271898247991;9128.361014729171;9178.495182765013;9190.632374704937;9328.440293582407;9657.062564856204;9716.562754676197;9804.313698041069;9931.354461959949;10242.231832612733;2900.4199160167627;3706.777593344408;5313.415524292402;8765.561721913751;9423.717288481357;7266.418686504961;7270.927290727025;7392.371648409945;7412.518186317872;7425.480216384801;8225;8711.782205444915;8841.425307355259;8921.375503714678;8962.641494340154 08:11:04 INFO - PROCESS | 23789 | |3;mootools.html;1338.2171429713617;1447.102796266315;1476.2766244540176;1605.486244401792;1766.0463349791114;7207.711691532339;7705.422093343001;7883.80290492738;7885.723999660013;7902.170272121431;7770.572618505994;7904.170062143478;7948.96025519873;7962.761117166494;7976.680932762697;1999.1203870297022;2042.4077017664858;2285.1202287119413;2304.158981971577;2324.709411323576;2363.314638754759;2364.326167042393;2373.667686523888;2375.893084811179;2378.5718570657273;2265.4676151104477;2330.627099664054;2331.522037982218;2331.6502524621274;2334.5214231082587;2237.686723858661;2258.062903894882;2317.7566355532763;2320.5938960681983;2321.7578595451437;2325.5348930214027;2328.1734984080576;2338.9532209355716;2346.6949296591506;2360.1857359211044;8046.959765201195;8092.757217283491;8113.918860811375;8117.269445749911;8126.918730812676;4871.098846713334;5001.249812528114;5043.293938848564;5043.394792624872;5044.066847633199;3053.5267033609825;3105.813651180936;3150.9684903150905;3169.904902852918;3203.423383790917;1027.6660085472176;1864.3567969050655;1893.810618938109;1909.7326374307609;1944.4847115514401;10851.348919064882;10962.671119866416;10990.120790336754;10994.450277486174;10996.505157267942;4309.375140604658;4350.412694286231;4428.800703968264;4430.955690443118;4465.933011004838;8852.734417967471;8867.600957956907;8882.555872206363;8888.6000129993;8907.599158037903;4919.188333924933;4950.975245123751;4978.054169707744;4981.825636102719;5002.649814512949;4517.006258623098;4559.931601025987;4607.7004994675235;4612.469565999886;4613.123506533748;3420.521127042216;3476.652334766503;3618.203995121069;3666.7433279670167;3697.4453831925425;1151.631477927072;1153.867305259889;1159.1943599198644;1160.808466603001;1161.8431511745976;1248.5318005747845;1270.5299039355314;1292.9418176182094;1305.4582348325528;1306.45129045801;7172.354488096096;7175.067241258603;7427.331540161304;7593.772186834404;7605.581693006938;1078.2991055813627;1078.5362294213407;1092.1372116028408;1104.7845670094255;1120.1878637987395;5902.793402230901;6029.186059881948;6032.306284777307;6043.607165534227;6045.848853778691;9562.808743825084;9842.606295748234;9946.602135914627;9958.452285124244;10092.142167915663;9788.363756355957;10031.899681003242;10057;10064.54709538058;10072.143867771321;7303.744368947061;7694.615269236628;7704.345130663844;7735.187805280365;7779;7281.5631062136445;7395.778126656209;7419.9258007421395;7434.628268586657;7447.478676492594;8499.57502124879;8922.509261990393;8995;8997.865032024394;9028.638854445748;8654.697085602225;8689.652413903626;8700;8735.956320218358;8880.955595221982;6425.5502114851515;6627.50293727982;6716.865662686817;6742.157230346207;6757.493188011017;7058.11773528309;7422.14645315774;7616.7334143304715;7625.428092892944;7629.465937384552;6795.72817087311;7011.053507776385;7115.2884711530505;7161.534500257467;7271.200167981412;6994.125734283215;7078;7113.2175460698245;7217.566945983258;7219.783406497813;7228.927710722825;7269.091363579552;7285.854282914206;7353.558786472829;7380.630968451664;6521.282658907611;6526.608403495806;6555.344465553407;6561.114249576246;6563.245226798979;6441.516886233458;6856.6228857413325;6907.481938854506;6908.1019467470915;6911.861762764616 08:11:04 INFO - PROCESS | 23789 | |4;prototype.html;337.4583793012215;346.1933694491834;350.09500441359086;351.23430920593114;351.44998078007916;5788.305403351593;5861.2087368205275;5867.530597552191;5910.970445147774;5941.168236446895;5680;5803.883922321551;5863.1205319202145;5866.472017518422;5878.706064696769;4579.12996530659;4586.44962604488;4590.793414296365;4597.057603191338;4598.471175814774;4358.302671572549;4456.465224173087;4474.306482495218;4562.6121779648765;4588.77056147193;4538.500764915857;4552.931706024412;4554.590086892179;4560.612347950429;4582.77086145693;4553.840615578455;4565.589096981254;4569.086182763461;4573.908521829578;4580.633549316047;4030.576789437096;4049.2104039712267;4051.554329023805;4055.1281474483126;4059.776712280823;5382;5522.585806064521;5529.170624406331;5534.4742249486235;5548.306461692288;5161.5870730341485;5171.3535808024;5171.715555644438;5175.430702622709;5176.715280659562;5982.73077711504;6265.624062556261;6309.3690630937;6310.7791227306825;6314.179156709644;4245.532991370947;4280.036991676879;4371.890702732457;4375.321825117112;4376.496702879178;6397.360263973612;6504.219493660744;6507.772227972046;6509.3490650935;6519.739210431577;4465.575770301816;4469.575390337913;4476.574725401082;4477.932831007537;4479.462464504215;4409;4478.39541661878;4533.818647254139;4537.251353526697;4544.977380089519;5186;5250.713575174107;5252.238425428368;5255.343082114736;5256.448072952361;6321.683915804191;6321.936780632227;6326.873462530723;6330.240371155399;6332.588381755263;1585.2786981923198;1617.6360318928148;1617.6683779825107;1618.6681730245507;1620.9270582823801;1072.3351522056219;1077.2459278505078;1077.7467295185625;1088.1240601315858;1105.3367979212408;5920.319163296276;5931.4958228550195;5934.317553481319;5941.405859414024;5943.940560594425;6340.985442329205;6386.936130638727;6428.55000149985;6433.710483028275;6435.06691529735;5914.645121292736;5927.585069045125;5927.792527261525;5928.725324055349;5939.82180534576;3380.1211684962086;3476.8783092592143;3477.1480987158307;3478.652134786552;3483.111806489329;6702.932970670231;6756.391924726799;6773;6779.864402711918;6792.864142717217;6608.900866487006;6621.668916554153;6634.0712300278;6641.800745977628;6642.900356494656;6557.245916719543;6665.366790154928;6756.155480564929;6766.424853887376;6771.559848609824;6191.071339299141;6371.267304260069;6438.806835794933;6484.4812415005745;6489.059086432535;6314.968425157845;6492.188476440445;6495.740170393131;6513.7068831903625;6522;6757.662116894234;6757.729690812313;6769.120014398097;6772.93227067723;6773.559718618274;4329.935050974301;4487.394201782718;4571.931421028621;4572.45130584332;4579.290210017452;6521.380468855451;6547.869042619026;6614.867702646016;6620.040094186413;6627.271000190071;6330.430261276507;6332.430081292706;6343.52423568225;6354;6354.872902542016;6215.223097112861;6325.462335701517;6336.081268216175;6336.841578960563;6339.587926784744;6163.075538669235;6191.349908259568;6202.596831205957;6207.596506227081;6209.937900620936;6407.295197528175;6416.615003099829;6426.839329016812;6442.90335644975;6445.2265728112925;6068.4841788448475;6187.81436556904;6206.06908963659;6214.72033758491;6231.096491008869 08:11:04 INFO - PROCESS | 23789 | |5;yui.html;820.2740574591488;824.1964085017105;830.3315830756246;834.4659417972498;836.43958547773;12764.80852787209;12953.546625868084;12973.805392919103;12976.480940762358;13008.089433739642;12476.500939962414;12625;12712.618621441348;12916.741665166715;13023.739525209514;789.2778108031144;802.7230605441114;802.743122200896;804.3806269172734;804.4409135650695;659.4724220623506;668.2115104177069;784.8979632647748;793.1275596843484;798.8082860113589;832.097174565597;838.9203025712578;840.684743221292;842.0400743152811;844.1010324004945;837.1837458477966;837.3803385494751;837.9413441059128;839.1189251286186;839.8656215005569;508.35438992479345;514.4803748214293;601.2604496469323;616.6238594457377;618.060547967092;13702.794458083137;13711.177329360271;13718;13724.862751372459;13800.861991380058;12196.329201893892;12734.872651273461;12782.360881955865;12982.675433114153;13033.218006919615;10388.272820902539;10414.166866650725;10467.790644187073;10542.947285263524;11066.889331106666;3542.3092496963104;3595.9101022474647;3641.3445579795625;3648.0515066083008;3706.09200745819;46096.53903460956;46128.76935615334;46494.53505464936;47200.76399618014;49317.506824931654;9057.728268151966;9262.953685231665;9314.115159059878;9355.111264429868;9792.706218813448;16949.237284322237;17050.82949170517;17129.14354282281;17177.484675459757;17185.484435466955;7178.353948144588;7257.2742725727;7299.306565876233;7350.08123984502;7572.507786993938;4222.366645003274;4225.239456897788;4246.299360605527;4249.617534421917;4324.706139849083;3076.7384772294604;3105.813651180936;3113.8598763055716;3116.719495245439;3123.2660324823646;564.0692856786335;605.1860247966478;619.6220305613572;622.1165944359021;643.276314146585;541.2233445006428;565.4712843491349;622.7820262908036;628.7013668507514;677.8779819632415;7854.646540905673;8145.978152929493;8228.465149765367;8252.381071419668;8424.28393586552;502.63810056759075;519.3508114856429;603.2459425717852;614.8555089553952;637.576011952056;3981.144054028398;3984.040048573731;4087.7547347159266;4089.8568550100604;4165;55043;55520.44479555153;55556.44443555594;55605.44394556084;55691;48630.51369486331;49250.26124608134;49685.50314496809;50333.496665033614;50438;42381.36427953583;43264.78367608142;43884.341734874004;44209;44295.77852110719;8298.502089874626;8476.703315384178;8523.786905327417;8673.132686731276;8720.171583699539;33399.666003339655;33441.996740097835;34203.31593368168;34229.828850855585;34848.12879677927;38905.6109438902;38927.2214555713;41248.38127428031;42148.36777448402;42452;10652.520636571528;10741.624043158765;10840.241183117107;11029.558817647205;11156.107511398906;12213.45039473208;12299.323537205539;12502.249865008129;12918.547850825553;12964.675883102998;9910.504474776377;10726.088282495763;10767.676969690921;10888.128949684165;11194.326749020167;10465.319754215952;10730.517126729159;10856.891431085589;11217.71955701114;11269.211155219384;10579.89420105789;10621.468926553796;10688.412137332522;10717.410542420243;11094.223404361617;9203;9577.23382129414;9581.90418095838;9693.951530242304;9766.609335626496;8503.702370417006;8582.184692454206;8860.113988601346;9455.290853185901;9510.413313191902 08:11:04 INFO - PROCESS | 23789 | __end_tp_report 08:11:04 INFO - PROCESS | 23789 | __start_cc_report 08:11:04 INFO - PROCESS | 23789 | _x_x_mozilla_cycle_collect,892 08:11:04 INFO - PROCESS | 23789 | __end_cc_report 08:11:04 INFO - PROCESS | 23789 | __startTimestamp1453392664321__endTimestamp 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | ------- Summary: start ------- 08:11:04 INFO - PROCESS | 23789 | Number of tests: 6 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#0] dojo.html Cycles:165 Average:5223.72 Median:5452.48 stddev:573.29 (10.5%) stddev-sans-first:550.48 08:11:04 INFO - PROCESS | 23789 | Values: 3107.0 3125.6 3169.1 3175.0 3202.4 5088.4 5155.3 5220.3 5237.9 5242.8 5098.0 5118.2 5239.4 5292.3 5299.7 4755.5 4802.0 4814.4 4880.1 4913.3 4732.1 4856.2 4867.9 4904.0 4921.0 4731.9 4822.1 4845.2 4917.1 4919.0 4747.0 4813.8 4814.8 4827.1 4858.8 4749.2 4753.8 4761.3 4764.4 4768.4 5003.1 5004.2 5042.4 5077.8 5082.6 5660.6 5661.8 5663.7 5669.5 5673.5 5670.5 5671.8 5683.1 5683.5 5683.8 5175.3 5247.6 5250.6 5292.5 5357.4 5778.2 5784.2 5787.6 5804.4 5842.5 5545.8 5555.6 5562.8 5567.1 5568.8 5541.8 5601.7 5619.2 5630.7 5705.2 5608.8 5609.0 5611.4 5612.7 5630.8 5484.5 5569.5 5620.1 5620.7 5639.5 4369.3 4372.0 4391.6 4404.3 4452.0 3873.4 3876.0 3888.1 3910.1 3921.7 5066.5 5149.9 5170.7 5181.2 5208.2 5578.5 5612.1 5614.0 5637.3 5663.1 5150.6 5169.7 5169.8 5170.6 5207.0 4713.4 4786.1 4793.8 4811.6 4814.2 5848.4 5849.7 5862.3 5873.8 5882.5 5590.0 5593.9 5599.5 5603.1 5610.7 5626.9 5758.8 5800.0 5836.3 5944.0 5531.0 5536.5 5545.1 5548.3 5548.6 5570.1 5621.8 5622.4 5628.9 5630.9 5422.0 5497.8 5510.6 5579.1 5587.3 5480.9 5532.2 5539.1 5541.3 5543.1 5450.8 5453.2 5464.3 5465.5 5507.2 5441.4 5486.1 5531.1 5556.3 5595.2 5401.6 5401.8 5406.1 5407.8 5452.5 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#1] ext.html Cycles:180 Average:43814.34 Median:34029.49 stddev:73687.38 (216.5%) stddev-sans-first:73822.44 08:11:04 INFO - PROCESS | 23789 | Values: 537.0 540.6 550.0 564.2 576.6 27543.0 28076.2 34467.5 35208.3 35284.6 38229.4 38702.2 38724.8 38742.0 38783.6 8353.1 8500.4 8582.3 8588.4 8596.1 8332.8 8432.3 8445.7 8473.7 8474.6 8592.7 8655.6 8670.0 8672.5 8681.9 8540.3 8610.4 8621.1 8625.6 8626.1 8506.5 8604.0 8654.7 8664.1 8667.3 38810.0 39175.8 39229.0 39261.2 39263.2 3203.3 3242.1 3549.2 3800.9 3917.2 27360.6 27563.7 29253.4 29389.4 30650.0 3815.7 3883.8 3926.3 4056.9 4058.7 243865.0 244887.0 264483.0 264968.0 265100.0 52300.5 52489.0 52573.2 52576.7 52659.0 56704.7 56838.7 56979.7 57050.0 57070.1 14027.7 14276.1 14356.5 14365.5 14400.6 10944.7 10973.9 10985.2 10992.0 10995.0 17789.0 17849.3 18011.7 18013.4 18028.5 6594.9 7030.4 7135.5 7139.6 7200.4 893.9 1009.5 1065.8 1086.9 1101.8 27820.3 29885.9 29916.7 30396.0 30412.0 911.2 984.4 992.5 1013.8 1031.3 12699.7 13177.2 13211.3 13238.9 13301.3 312091.0 323256.0 328315.0 328635.0 329534.0 38671.2 48012.3 49487.0 49582.5 49620.3 1298.3 1308.8 1313.9 1316.6 1321.0 24008.8 25162.4 26445.2 28957.3 29293.4 43531.0 44794.3 44802.6 44806.6 44832.6 256773.0 259006.0 259158.0 259252.0 259320.0 30956.8 31580.7 31658.4 31667.8 31698.8 39785.6 40727.8 41152.4 41211.2 42615.8 31526.8 31851.5 32635.3 32685.8 33591.5 31078.4 31498.4 31771.4 31992.7 32090.0 31920.0 34937.8 35472.8 35765.8 35842.3 27370.9 29135.0 29919.7 30748.9 31841.0 22219.3 22305.0 22412.7 22475.0 22614.5 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#2] jquery.html Cycles:180 Average:25258.61 Median:264465.87 stddev:81739.92 (30.9%) stddev-sans-first:81947.85 08:11:04 INFO - PROCESS | 23789 | Values: 365.5 367.8 367.9 368.3 373.2 13188.8 13295.5 15636.1 16919.5 17924.5 15118.1 15463.7 15530.4 15606.8 16474.8 5282.7 5448.3 5450.4 5450.9 5473.7 3931.0 4084.4 5374.7 5403.0 5786.9 5688.3 5885.6 5940.4 5948.4 5953.7 5853.3 5854.8 5874.5 5878.9 5908.2 4783.7 4930.3 4951.5 5163.4 5177.7 11730.6 11808.5 13378.7 18984.8 19088.6 2017.9 2071.6 2081.0 2115.1 2135.8 8634.9 8820.6 9055.9 9322.4 12448.2 1708.4 1805.3 1827.8 1828.9 1841.2 48371.8 49261.0 49461.5 50051.5 50810.7 8991.3 9059.5 9192.7 9254.1 9356.1 12273.1 12291.6 12298.3 12311.0 12362.1 6794.7 7055.8 7118.5 7128.4 7199.6 6892.8 6952.2 6980.5 6999.7 7026.5 4045.7 4163.8 4261.4 4280.9 4314.5 1583.5 1592.9 1636.7 1672.9 1688.1 829.0 853.9 882.7 947.8 998.8 14702.4 15319.0 15411.0 15622.8 15690.7 856.8 909.6 924.2 925.2 930.8 9213.4 9315.0 9410.8 9433.1 9471.7 345260.0 517126.0 523754.0 540037.0 547231.0 52813.5 68730.3 69821.3 70037.0 72021.0 1048.8 1058.8 1077.5 1079.1 1081.8 14031.6 14566.9 14837.9 15095.2 15124.7 29805.3 30660.4 30911.2 30926.0 31122.7 36785.4 37391.4 37635.0 38994.0 40880.8 7061.5 7216.8 7222.4 7382.5 7421.6 8492.4 8929.8 10822.6 11227.7 11438.9 9101.3 9128.4 9178.5 9190.6 9328.4 9657.1 9716.6 9804.3 9931.4 10242.2 2900.4 3706.8 5313.4 8765.6 9423.7 7266.4 7270.9 7392.4 7412.5 7425.5 8225.0 8711.8 8841.4 8921.4 8962.6 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#3] mootools.html Cycles:180 Average:5623.72 Median:5965.99 stddev:2883.24 (48.3%) stddev-sans-first:2873.33 08:11:04 INFO - PROCESS | 23789 | Values: 1338.2 1447.1 1476.3 1605.5 1766.0 7207.7 7705.4 7883.8 7885.7 7902.2 7770.6 7904.2 7949.0 7962.8 7976.7 1999.1 2042.4 2285.1 2304.2 2324.7 2363.3 2364.3 2373.7 2375.9 2378.6 2265.5 2330.6 2331.5 2331.7 2334.5 2237.7 2258.1 2317.8 2320.6 2321.8 2325.5 2328.2 2339.0 2346.7 2360.2 8047.0 8092.8 8113.9 8117.3 8126.9 4871.1 5001.2 5043.3 5043.4 5044.1 3053.5 3105.8 3151.0 3169.9 3203.4 1027.7 1864.4 1893.8 1909.7 1944.5 10851.3 10962.7 10990.1 10994.5 10996.5 4309.4 4350.4 4428.8 4431.0 4465.9 8852.7 8867.6 8882.6 8888.6 8907.6 4919.2 4951.0 4978.1 4981.8 5002.6 4517.0 4559.9 4607.7 4612.5 4613.1 3420.5 3476.7 3618.2 3666.7 3697.4 1151.6 1153.9 1159.2 1160.8 1161.8 1248.5 1270.5 1292.9 1305.5 1306.5 7172.4 7175.1 7427.3 7593.8 7605.6 1078.3 1078.5 1092.1 1104.8 1120.2 5902.8 6029.2 6032.3 6043.6 6045.8 9562.8 9842.6 9946.6 9958.5 10092.1 9788.4 10031.9 10057.0 10064.5 10072.1 7303.7 7694.6 7704.3 7735.2 7779.0 7281.6 7395.8 7419.9 7434.6 7447.5 8499.6 8922.5 8995.0 8997.9 9028.6 8654.7 8689.7 8700.0 8736.0 8881.0 6425.6 6627.5 6716.9 6742.2 6757.5 7058.1 7422.1 7616.7 7625.4 7629.5 6795.7 7011.1 7115.3 7161.5 7271.2 6994.1 7078.0 7113.2 7217.6 7219.8 7228.9 7269.1 7285.9 7353.6 7380.6 6521.3 6526.6 6555.3 6561.1 6563.2 6441.5 6856.6 6907.5 6908.1 6911.9 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#4] prototype.html Cycles:180 Average:5257.27 Median:5923.95 stddev:1578.82 (26.7%) stddev-sans-first:1539.46 08:11:04 INFO - PROCESS | 23789 | Values: 337.5 346.2 350.1 351.2 351.4 5788.3 5861.2 5867.5 5911.0 5941.2 5680.0 5803.9 5863.1 5866.5 5878.7 4579.1 4586.4 4590.8 4597.1 4598.5 4358.3 4456.5 4474.3 4562.6 4588.8 4538.5 4552.9 4554.6 4560.6 4582.8 4553.8 4565.6 4569.1 4573.9 4580.6 4030.6 4049.2 4051.6 4055.1 4059.8 5382.0 5522.6 5529.2 5534.5 5548.3 5161.6 5171.4 5171.7 5175.4 5176.7 5982.7 6265.6 6309.4 6310.8 6314.2 4245.5 4280.0 4371.9 4375.3 4376.5 6397.4 6504.2 6507.8 6509.3 6519.7 4465.6 4469.6 4476.6 4477.9 4479.5 4409.0 4478.4 4533.8 4537.3 4545.0 5186.0 5250.7 5252.2 5255.3 5256.4 6321.7 6321.9 6326.9 6330.2 6332.6 1585.3 1617.6 1617.7 1618.7 1620.9 1072.3 1077.2 1077.7 1088.1 1105.3 5920.3 5931.5 5934.3 5941.4 5943.9 6341.0 6386.9 6428.6 6433.7 6435.1 5914.6 5927.6 5927.8 5928.7 5939.8 3380.1 3476.9 3477.1 3478.7 3483.1 6702.9 6756.4 6773.0 6779.9 6792.9 6608.9 6621.7 6634.1 6641.8 6642.9 6557.2 6665.4 6756.2 6766.4 6771.6 6191.1 6371.3 6438.8 6484.5 6489.1 6315.0 6492.2 6495.7 6513.7 6522.0 6757.7 6757.7 6769.1 6772.9 6773.6 4329.9 4487.4 4571.9 4572.5 4579.3 6521.4 6547.9 6614.9 6620.0 6627.3 6330.4 6332.4 6343.5 6354.0 6354.9 6215.2 6325.5 6336.1 6336.8 6339.6 6163.1 6191.3 6202.6 6207.6 6209.9 6407.3 6416.6 6426.8 6442.9 6445.2 6068.5 6187.8 6206.1 6214.7 6231.1 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - PROCESS | 23789 | [#5] yui.html Cycles:180 Average:13323.10 Median:46311.65 stddev:15244.18 (32.9%) stddev-sans-first:15258.03 08:11:04 INFO - PROCESS | 23789 | Values: 820.3 824.2 830.3 834.5 836.4 12764.8 12953.5 12973.8 12976.5 13008.1 12476.5 12625.0 12712.6 12916.7 13023.7 789.3 802.7 802.7 804.4 804.4 659.5 668.2 784.9 793.1 798.8 832.1 838.9 840.7 842.0 844.1 837.2 837.4 837.9 839.1 839.9 508.4 514.5 601.3 616.6 618.1 13702.8 13711.2 13718.0 13724.9 13800.9 12196.3 12734.9 12782.4 12982.7 13033.2 10388.3 10414.2 10467.8 10542.9 11066.9 3542.3 3595.9 3641.3 3648.1 3706.1 46096.5 46128.8 46494.5 47200.8 49317.5 9057.7 9263.0 9314.1 9355.1 9792.7 16949.2 17050.8 17129.1 17177.5 17185.5 7178.4 7257.3 7299.3 7350.1 7572.5 4222.4 4225.2 4246.3 4249.6 4324.7 3076.7 3105.8 3113.9 3116.7 3123.3 564.1 605.2 619.6 622.1 643.3 541.2 565.5 622.8 628.7 677.9 7854.6 8146.0 8228.5 8252.4 8424.3 502.6 519.4 603.2 614.9 637.6 3981.1 3984.0 4087.8 4089.9 4165.0 55043.0 55520.4 55556.4 55605.4 55691.0 48630.5 49250.3 49685.5 50333.5 50438.0 42381.4 43264.8 43884.3 44209.0 44295.8 8298.5 8476.7 8523.8 8673.1 8720.2 33399.7 33442.0 34203.3 34229.8 34848.1 38905.6 38927.2 41248.4 42148.4 42452.0 10652.5 10741.6 10840.2 11029.6 11156.1 12213.5 12299.3 12502.2 12918.5 12964.7 9910.5 10726.1 10767.7 10888.1 11194.3 10465.3 10730.5 10856.9 11217.7 11269.2 10579.9 10621.5 10688.4 10717.4 11094.2 9203.0 9577.2 9581.9 9694.0 9766.6 8503.7 8582.2 8860.1 9455.3 9510.4 08:11:04 INFO - PROCESS | 23789 | -------- Summary: end -------- 08:11:04 INFO - PROCESS | 23789 | 08:11:04 INFO - TEST-INFO | 23789: exit 0 08:11:05 INFO - TEST-OK | dromaeo_css | took 1111964ms 08:11:05 INFO - TEST-START | kraken 08:11:05 INFO - operating with platform_type : linux_ 08:11:05 INFO - Initialising browser for kraken test... 08:11:05 INFO - TEST-INFO | started process 23985 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph024nu/profile http://localhost:35192/getInfo.html) 08:11:09 INFO - PROCESS | 23985 | __metrics Screen width/height:1600/1200 08:11:09 INFO - PROCESS | 23985 | colorDepth:24 08:11:09 INFO - PROCESS | 23985 | Browser inner width/height: 1024/697 08:11:09 INFO - PROCESS | 23985 | __metrics 08:11:09 INFO - PROCESS | 23985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:11:09 INFO - PROCESS | 23985 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:09 INFO - TEST-INFO | 23985: exit 0 08:11:09 INFO - Browser initialized. 08:11:09 INFO - Running cycle 1/1 for kraken test... 08:11:09 INFO - TEST-INFO | started process 24068 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph024nu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:21 INFO - PROCESS | 24068 | RSS: Main: 148725760 08:11:21 INFO - PROCESS | 24068 | 08:11:24 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:24 INFO - PROCESS | 24068 | RSS: Main: 183906304 08:11:24 INFO - PROCESS | 24068 | 08:11:27 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-dft) 08:11:28 INFO - PROCESS | 24068 | RSS: Main: 175755264 08:11:28 INFO - PROCESS | 24068 | 08:11:30 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-fft) 08:11:31 INFO - PROCESS | 24068 | RSS: Main: 162291712 08:11:31 INFO - PROCESS | 24068 | 08:11:33 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35192/tests/kraken/driver.html?testName=audio-oscillator) 08:11:34 INFO - PROCESS | 24068 | RSS: Main: 165044224 08:11:34 INFO - PROCESS | 24068 | 08:11:36 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:36 INFO - PROCESS | 24068 | RSS: Main: 164868096 08:11:36 INFO - PROCESS | 24068 | 08:11:39 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:40 INFO - PROCESS | 24068 | RSS: Main: 165711872 08:11:40 INFO - PROCESS | 24068 | 08:11:43 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35192/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:44 INFO - PROCESS | 24068 | RSS: Main: 165318656 08:11:44 INFO - PROCESS | 24068 | 08:11:47 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35192/tests/kraken/driver.html?testName=json-parse-financial) 08:11:47 INFO - PROCESS | 24068 | RSS: Main: 166793216 08:11:47 INFO - PROCESS | 24068 | 08:11:49 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35192/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:49 INFO - PROCESS | 24068 | RSS: Main: 180285440 08:11:49 INFO - PROCESS | 24068 | 08:11:51 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:11:52 INFO - PROCESS | 24068 | RSS: Main: 179687424 08:11:52 INFO - PROCESS | 24068 | 08:11:54 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:11:54 INFO - PROCESS | 24068 | RSS: Main: 182894592 08:11:54 INFO - PROCESS | 24068 | 08:11:57 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:11:57 INFO - PROCESS | 24068 | RSS: Main: 191815680 08:11:57 INFO - PROCESS | 24068 | 08:12:00 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:00 INFO - PROCESS | 24068 | RSS: Main: 189620224 08:12:00 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | Cycle 1(1): loaded http://localhost:35192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35192/tests/kraken/driver.html?testName=ai-astar) 08:12:02 INFO - PROCESS | 24068 | RSS: Main: 248668160 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | __start_tp_report 08:12:02 INFO - PROCESS | 24068 | _x_x_mozilla_page_load 08:12:02 INFO - PROCESS | 24068 | _x_x_mozilla_page_load_details 08:12:02 INFO - PROCESS | 24068 | |i|pagename|runs| 08:12:02 INFO - PROCESS | 24068 | |0;ai-astar;112;109;105;109;109;110;110;110;104;111 08:12:02 INFO - PROCESS | 24068 | |1;audio-beat-detection;154;131;152;160;127;157;153;133;168;129 08:12:02 INFO - PROCESS | 24068 | |2;audio-dft;161;161;160;161;162;161;161;160;162;163 08:12:02 INFO - PROCESS | 24068 | |3;audio-fft;73;73;107;98;74;73;72;117;92;72 08:12:02 INFO - PROCESS | 24068 | |4;audio-oscillator;96;97;151;96;96;95;147;94;97;137 08:12:02 INFO - PROCESS | 24068 | |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;109;109 08:12:02 INFO - PROCESS | 24068 | |6;imaging-darkroom;146;146;145;145;147;146;146;146;146;145 08:12:02 INFO - PROCESS | 24068 | |7;imaging-desaturate;95;95;96;96;95;97;96;95;95;96 08:12:02 INFO - PROCESS | 24068 | |8;json-parse-financial;57;56;56;55;54;64;56;56;56;53 08:12:02 INFO - PROCESS | 24068 | |9;json-stringify-tinderbox;67;69;69;67;68;68;68;68;68;67 08:12:02 INFO - PROCESS | 24068 | |10;stanford-crypto-aes;92;83;83;85;86;85;84;85;83;84 08:12:02 INFO - PROCESS | 24068 | |11;stanford-crypto-ccm;118;117;121;119;119;122;128;120;116;124 08:12:02 INFO - PROCESS | 24068 | |12;stanford-crypto-pbkdf2;156;143;155;151;155;146;153;156;152;153 08:12:02 INFO - PROCESS | 24068 | |13;stanford-crypto-sha256-iterative;71;72;72;68;71;67;68;69;69;70 08:12:02 INFO - PROCESS | 24068 | __end_tp_report 08:12:02 INFO - PROCESS | 24068 | __start_cc_report 08:12:02 INFO - PROCESS | 24068 | _x_x_mozilla_cycle_collect,928 08:12:02 INFO - PROCESS | 24068 | __end_cc_report 08:12:02 INFO - PROCESS | 24068 | __startTimestamp1453392722909__endTimestamp 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | ------- Summary: start ------- 08:12:02 INFO - PROCESS | 24068 | Number of tests: 14 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.51 (2.3%) stddev-sans-first:2.40 08:12:02 INFO - PROCESS | 24068 | Values: 112.0 109.0 105.0 109.0 109.0 110.0 110.0 110.0 104.0 111.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:153.50 stddev:14.88 (9.7%) stddev-sans-first:15.53 08:12:02 INFO - PROCESS | 24068 | Values: 154.0 131.0 152.0 160.0 127.0 157.0 153.0 133.0 168.0 129.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:12:02 INFO - PROCESS | 24068 | Values: 161.0 161.0 160.0 161.0 162.0 161.0 161.0 160.0 162.0 163.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#3] audio-fft Cycles:10 Average:85.10 Median:73.00 stddev:17.05 (23.4%) stddev-sans-first:17.52 08:12:02 INFO - PROCESS | 24068 | Values: 73.0 73.0 107.0 98.0 74.0 73.0 72.0 117.0 92.0 72.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.00 stddev:24.00 (25.0%) stddev-sans-first:24.86 08:12:02 INFO - PROCESS | 24068 | Values: 96.0 97.0 151.0 96.0 96.0 95.0 147.0 94.0 97.0 137.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:12:02 INFO - PROCESS | 24068 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:12:02 INFO - PROCESS | 24068 | Values: 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 145.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 08:12:02 INFO - PROCESS | 24068 | Values: 95.0 95.0 96.0 96.0 95.0 97.0 96.0 95.0 95.0 96.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.95 (5.3%) stddev-sans-first:3.11 08:12:02 INFO - PROCESS | 24068 | Values: 57.0 56.0 56.0 55.0 54.0 64.0 56.0 56.0 56.0 53.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 08:12:02 INFO - PROCESS | 24068 | Values: 67.0 69.0 69.0 67.0 68.0 68.0 68.0 68.0 68.0 67.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:1.09 08:12:02 INFO - PROCESS | 24068 | Values: 92.0 83.0 83.0 85.0 86.0 85.0 84.0 85.0 83.0 84.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.50 stddev:3.57 (3.0%) stddev-sans-first:3.67 08:12:02 INFO - PROCESS | 24068 | Values: 118.0 117.0 121.0 119.0 119.0 122.0 128.0 120.0 116.0 124.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:154.00 stddev:4.35 (2.8%) stddev-sans-first:4.36 08:12:02 INFO - PROCESS | 24068 | Values: 156.0 143.0 155.0 151.0 155.0 146.0 153.0 156.0 152.0 153.0 08:12:02 INFO - PROCESS | 24068 | 08:12:02 INFO - PROCESS | 24068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.50 stddev:1.77 (2.5%) stddev-sans-first:1.81 08:12:02 INFO - PROCESS | 24068 | Values: 71.0 72.0 72.0 68.0 71.0 67.0 68.0 69.0 69.0 70.0 08:12:02 INFO - PROCESS | 24068 | -------- Summary: end -------- 08:12:02 INFO - PROCESS | 24068 | 08:12:03 INFO - TEST-INFO | 24068: exit 0 08:12:03 INFO - TEST-OK | kraken | took 58810ms 08:12:03 INFO - TEST-START | v8_7 08:12:03 INFO - operating with platform_type : linux_ 08:12:03 INFO - Initialising browser for v8_7 test... 08:12:03 INFO - TEST-INFO | started process 24316 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuOAt8/profile http://localhost:35192/getInfo.html) 08:12:07 INFO - PROCESS | 24316 | __metrics Screen width/height:1600/1200 08:12:07 INFO - PROCESS | 24316 | colorDepth:24 08:12:07 INFO - PROCESS | 24316 | Browser inner width/height: 1024/697 08:12:07 INFO - PROCESS | 24316 | __metrics 08:12:07 INFO - PROCESS | 24316 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:12:07 INFO - PROCESS | 24316 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:08 INFO - TEST-INFO | 24316: exit 0 08:12:08 INFO - Browser initialized. 08:12:08 INFO - Running cycle 1/1 for v8_7 test... 08:12:08 INFO - TEST-INFO | started process 24401 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxuOAt8/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:20 INFO - PROCESS | 24401 | RSS: Main: 149807104 08:12:20 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | Cycle 1(1): loaded http://localhost:35192/tests/v8_7/run.html (next: http://localhost:35192/tests/v8_7/run.html) 08:12:43 INFO - PROCESS | 24401 | RSS: Main: 576638976 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | __start_tp_report 08:12:43 INFO - PROCESS | 24401 | _x_x_mozilla_page_load 08:12:43 INFO - PROCESS | 24401 | _x_x_mozilla_page_load_details 08:12:43 INFO - PROCESS | 24401 | |i|pagename|runs| 08:12:43 INFO - PROCESS | 24401 | |0;Richards;167.22408026755852 08:12:43 INFO - PROCESS | 24401 | |1;DeltaBlue;188.78610534264678 08:12:43 INFO - PROCESS | 24401 | |2;Encrypt;279.87685418415896 08:12:43 INFO - PROCESS | 24401 | |3;Decrypt;5306.878306878307 08:12:43 INFO - PROCESS | 24401 | |4;RayTrace;1962.7450980392157 08:12:43 INFO - PROCESS | 24401 | |5;Earley;797.4481658692185 08:12:43 INFO - PROCESS | 24401 | |6;Boyer;12292.682926829268 08:12:43 INFO - PROCESS | 24401 | |7;RegExp;43375 08:12:43 INFO - PROCESS | 24401 | |8;Splay;555.984555984556 08:12:43 INFO - PROCESS | 24401 | |9;NavierStokes;4826.923076923077 08:12:43 INFO - PROCESS | 24401 | __end_tp_report 08:12:43 INFO - PROCESS | 24401 | __startTimestamp1453392763272__endTimestamp 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | ------- Summary: start ------- 08:12:43 INFO - PROCESS | 24401 | Number of tests: 10 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 167.2 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 188.8 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 279.9 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#3] Decrypt Cycles:1 Average:5306.88 Median:5306.88 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 5306.9 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#4] RayTrace Cycles:1 Average:1962.75 Median:1962.75 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 1962.7 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#5] Earley Cycles:1 Average:797.45 Median:797.45 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 797.4 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 12292.7 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#7] RegExp Cycles:1 Average:43375.00 Median:43375.00 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 43375.0 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#8] Splay Cycles:1 Average:555.98 Median:555.98 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 556.0 08:12:43 INFO - PROCESS | 24401 | 08:12:43 INFO - PROCESS | 24401 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:12:43 INFO - PROCESS | 24401 | Values: 4826.9 08:12:43 INFO - PROCESS | 24401 | -------- Summary: end -------- 08:12:43 INFO - PROCESS | 24401 | 08:12:44 INFO - TEST-INFO | 24401: exit 0 08:12:44 INFO - TEST-OK | v8_7 | took 40318ms 08:12:44 INFO - SUITE-END | took 1211s 08:12:44 INFO - Completed test suite (00:20:11) 08:12:44 INFO - Working with test: dromaeo_css 08:12:44 INFO - Generating results file: dromaeo_css 08:12:44 INFO - Working with test: kraken 08:12:44 INFO - Generating results file: kraken 08:12:44 INFO - javascript benchmark 08:12:44 INFO - Working with test: v8_7 08:12:44 INFO - Generating results file: v8_7 08:12:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 08:12:44 INFO - process_Request line: dromaeo_css 6756.12 graph.html#tests=[[72,1,35]] 08:12:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:44 INFO - process_Request line: kraken 1514.00 graph.html#tests=[[232,1,35]] 08:12:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:12:44 INFO - process_Request line: v8_7 18965.74 graph.html#tests=[[230,1,35]] 08:12:44 INFO - RETURN: dromaeo_css: 6756.12 08:12:44 INFO - RETURN: kraken: 1514.00 08:12:44 INFO - RETURN: v8_7: 18965.74 08:12:44 INFO - javascript benchmark 08:12:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3106.9844650776745, 3125.5780469636593, 3169.065125787892, 3175.0, 3202.3755367703293, 5088.414832294287, 5155.329807125077, 5220.32135822343, 5237.8952420951555, 5242.842714718559, 5098.031374038939, 5118.232265160228, 5239.449857764937, 5292.285541451903, 5299.735013249341, 4755.476897541276, 4802.03959208158, 4814.422269327685, 4880.097182021337, 4913.31213630092, 4732.100900828848, 4856.198727210024, 4867.9269810952865, 4904.0191961607825, 4920.950790492103, 4731.929021064687, 4822.059698358787, 4845.152098382804, 4917.114919314522, 4919.0, 4746.952530474686, 4813.831515896962, 4814.807407703687, 4827.058723548909, 4858.78135483904, 4749.1926372516755, 4753.78607962639, 4761.285807128924, 4764.428268607755, 4768.356271903318, 5003.149464591028, 5004.249362595603, 5042.3949126104735, 5077.847664570068, 5082.593392528589, 5660.632058916157, 5661.7735290588325, 5663.7168141593165, 5669.546436285087, 5673.489385955284, 5670.518005969498, 5671.801486947937, 5683.090705487143, 5683.5169010634145, 5683.829485115453, 5175.275461435402, 5247.553957913582, 5250.6324557281005, 5292.470752924677, 5357.357117145967, 5778.248827652378, 5784.1902133701315, 5787.594868359259, 5804.4195580442465, 5842.474177324061, 5545.833624991256, 5555.555555555546, 5562.7774889004795, 5567.053600887859, 5568.805091821767, 5541.750621222055, 5601.719914004365, 5619.185218143346, 5630.746616402272, 5705.1727499512335, 5608.803691870847, 5609.046462101371, 5611.382747897728, 5612.747426365823, 5630.831075067755, 5484.478974497416, 5569.498745112959, 5620.072688006433, 5620.718964051781, 5639.492445679908, 4369.2790689536505, 4372.0, 4391.604755572014, 4404.339349097661, 4451.955480445219, 3873.4189871518934, 3875.9806200968815, 3888.066863952631, 3910.1006768443417, 3921.7254792164845, 5066.493350664904, 5149.922751158736, 5170.715610641376, 5181.248718935733, 5208.218767184952, 5578.497935185853, 5612.102063669875, 5614.045612245928, 5637.295338082739, 5663.065594176997, 5150.562202212854, 5169.741512924339, 5169.767360468788, 5170.6122040847085, 5207.010667973073, 4713.363695901009, 4786.090642777861, 4793.760311984387, 4811.639127065484, 4814.181589129857, 5848.4151584841175, 5849.707514624251, 5862.267216597926, 5873.794417195378, 5882.529397648178, 5590.049691552527, 5593.860153496195, 5599.496045355938, 5603.131514615241, 5610.7194640268635, 5626.88746225065, 5758.798442054508, 5799.971000144972, 5836.299644042742, 5944.048952167633, 5530.972345138249, 5536.529395001309, 5545.140503222007, 5548.306461692288, 5548.611597188158, 5570.080936645408, 5621.775128994958, 5622.437756224344, 5628.85927851807, 5630.943690563206, 5422.0, 5497.780088796403, 5510.614257002132, 5579.051561234681, 5587.273654424899, 5480.945190548044, 5532.2254884317035, 5539.058360078877, 5541.335039795089, 5543.057680194457, 5450.836474905759, 5453.236546883519, 5464.3442786865835, 5465.480779325958, 5507.173923911445, 5441.374241962067, 5486.067368547277, 5531.0873705839695, 5556.333240011225, 5595.216669666169, 5401.6218864679095, 5401.756920938646, 5406.107992181246, 5407.83776486706, 5452.482014208644], "unit": "score", "name": "dojo.html", "value": 5187.047322167283}, {"lowerIsBetter": false, "replicates": [536.9624126311157, 540.6053580885953, 549.9797874941985, 564.1932037186823, 576.5963825322273, 27543.035993740225, 28076.15771526855, 34467.482987755204, 35208.295834083365, 35284.64715352846, 38229.426558601575, 38702.22595548088, 38724.80637596808, 38742.0, 38783.61216387835, 8353.122922093184, 8500.404971651957, 8582.313414926792, 8588.441751286146, 8596.140385961417, 8332.750017499484, 8432.325413966868, 8445.746627601182, 8473.661053557851, 8474.576271186446, 8592.699255526059, 8655.610497527627, 8669.95665021674, 8672.479651220916, 8681.913180868205, 8540.316774658013, 8610.397272190949, 8621.094785047606, 8625.611847466847, 8626.094260102693, 8506.532140732257, 8604.0, 8654.740357789276, 8664.133586641348, 8667.30661547081, 38810.0, 39175.8041209795, 39229.0, 39261.21477570433, 39263.21473570513, 3203.2952750394875, 3242.1084201844446, 3549.2014296783277, 3800.923981520382, 3917.1773927475265, 27360.58959115615, 27563.72436275652, 29253.41493170146, 29389.412211755858, 30650.0, 3815.656590906804, 3883.7764655336005, 3926.312895243321, 4056.9249148975546, 4058.6955978301744, 243865.0, 244887.0, 264482.9999999981, 264968.0, 265100.0, 52300.476995230325, 52489.0, 52573.211401829, 52576.73711631417, 52659.0, 56704.71647641735, 56838.7158064207, 56979.715101425056, 57050.0, 57070.143947840814, 14027.71944561103, 14276.14343139415, 14356.497522586867, 14365.497207597684, 14400.567982960529, 10944.726381840517, 10973.945130274298, 10985.231033827555, 10992.0, 10994.95547922962, 17789.0, 17849.286028558712, 18011.72982405265, 18013.369532066314, 18028.459146225636, 6594.86810263792, 7030.437564994891, 7135.536190147727, 7139.571625702474, 7200.423966082701, 893.9374243802871, 1009.5103874620803, 1065.8488832061355, 1086.9076128529005, 1101.8071837428417, 27820.304492387448, 29885.850570747007, 29916.70083299139, 30396.0, 30412.0, 911.1526280559144, 984.4437892590663, 992.5313008190286, 1013.761765984993, 1031.3244824639723, 12699.682507937376, 13177.209367437792, 13211.273379964194, 13238.867611323956, 13301.26843023643, 312091.0, 323256.0, 328315.0, 328635.0, 329534.0, 38671.22657546833, 48012.279815802794, 49487.0, 49582.50417495851, 49620.25569616459, 1298.2794549025193, 1308.8036794480904, 1313.90802643814, 1316.6181807275975, 1320.9669758255927, 24008.811670479492, 25162.37094072663, 26445.206643800717, 28957.276068098465, 29293.414131717673, 43531.0, 44794.3280850794, 44802.55197447984, 44806.55193448024, 44832.551674482835, 256773.0, 259006.0, 259158.0, 259252.0, 259320.0, 30956.845215773777, 31580.684193157773, 31658.36683266368, 31667.84166079155, 31698.841505792323, 39785.60214397935, 40727.79636101919, 41152.38271425871, 41211.1757764849, 42615.786921066436, 31526.842365788023, 31851.522227167075, 32635.34729305353, 32685.836570816995, 33591.496127558596, 31078.37843243077, 31498.37003259968, 31771.364572707953, 31992.68007319897, 32090.0, 31920.0, 34937.8253108743, 35472.82263588665, 35765.82117089398, 35842.28315433729, 27370.863145684143, 29135.0, 29919.700802992564, 30748.929710637447, 31841.0, 22219.333419997427, 22305.0, 22412.66381004319, 22475.0, 22614.547709045397], "unit": "score", "name": "ext.html", "value": 17514.07617933717}, {"lowerIsBetter": false, "replicates": [365.4737178463013, 367.78484586516885, 367.8565359509791, 368.2947156195883, 373.17528262539787, 13188.802167967488, 13295.468181272738, 15636.140012299318, 16919.49241522753, 17924.462266132003, 15118.092914425142, 15463.69072618547, 15530.37878484862, 15606.765898511532, 16474.83525164748, 5282.656627319221, 5448.318960129984, 5450.427705090968, 5450.945490545084, 5473.67157970521, 3931.0, 4084.366923126905, 5374.677519348832, 5402.9729851350885, 5786.884262314751, 5688.288963879515, 5885.617434866741, 5940.3762604926505, 5948.375420580842, 5953.672548009858, 5853.268341457318, 5854.824355269348, 5874.530037597004, 5878.911816322759, 5908.172855800191, 4783.665143439961, 4930.260460930853, 4951.529604687549, 5163.432022477525, 5177.741112944375, 11730.589429369931, 11808.46861891217, 13378.665533361647, 18984.810151898444, 19088.618227635507, 2017.9495512612154, 2071.637463443891, 2081.0400219161766, 2115.132795553831, 2135.7543882453406, 8634.870476942851, 8820.603072861737, 9055.864162037575, 9322.36858549751, 12448.190867593577, 1708.4020592792547, 1805.3230038735473, 1827.7532533107992, 1828.8536917046604, 1841.1530695879912, 48371.758141209066, 49260.99999999964, 49461.50538494641, 50051.49948500505, 50810.7459462704, 8991.325650576233, 9059.501727404924, 9192.724218273463, 9254.074592540826, 9356.111169438893, 12273.140880138304, 12291.586467556166, 12298.262104273772, 12311.0, 12362.072844536695, 6794.660266986631, 7055.753048643375, 7118.537295075804, 7128.394086502602, 7199.640017999079, 6892.758753443605, 6952.200496942916, 6980.476464265201, 6999.650017499104, 7026.543274687129, 4045.696572757055, 4163.812628431728, 4261.424707664488, 4280.871573852789, 4314.482262128565, 1583.5249425172633, 1592.9203539823195, 1636.6726654669114, 1672.874534409924, 1688.1346112545705, 828.9886338666817, 853.9146085391411, 882.6734108379812, 947.8056998315329, 998.7602975286025, 14702.411903523953, 15319.0, 15411.0, 15622.76565851513, 15690.68618627621, 856.7729551668813, 909.5543183840003, 924.2236521322121, 925.2459245714721, 930.8464103422995, 9213.355065145375, 9314.95342523283, 9410.811783764424, 9433.103855133888, 9471.668491602899, 345260.0, 517126.0, 523754.0, 540037.0, 547231.0, 52813.47186528162, 68730.3126968724, 69821.30178698148, 70037.0, 72021.0, 1048.758785479344, 1058.8305871060593, 1077.52050337599, 1079.1312993040522, 1081.810683130449, 14031.579052628438, 14566.927165364104, 14837.92581037088, 15095.169765662993, 15124.697506049597, 29805.254868628457, 30660.386792264475, 30911.2272193197, 30926.0, 31122.68877311198, 36785.448218276215, 37391.439128413636, 37635.0, 38994.0, 40880.79559602302, 7061.470389720689, 7216.7834964951135, 7222.422206223595, 7382.52013619113, 7421.591812450367, 8492.447990880573, 8929.821403572023, 10822.621208257673, 11227.71930701739, 11438.94280528592, 9101.271898247991, 9128.361014729171, 9178.495182765013, 9190.632374704937, 9328.440293582407, 9657.062564856204, 9716.562754676197, 9804.313698041069, 9931.354461959949, 10242.231832612733, 2900.4199160167627, 3706.777593344408, 5313.415524292402, 8765.561721913751, 9423.717288481357, 7266.418686504961, 7270.927290727025, 7392.371648409945, 7412.518186317872, 7425.480216384801, 8225.0, 8711.782205444915, 8841.425307355259, 8921.375503714678, 8962.641494340154], "unit": "score", "name": "jquery.html", "value": 7692.964833010273}, {"lowerIsBetter": false, "replicates": [1338.2171429713617, 1447.102796266315, 1476.2766244540176, 1605.486244401792, 1766.0463349791114, 7207.711691532339, 7705.422093343001, 7883.80290492738, 7885.723999660013, 7902.170272121431, 7770.572618505994, 7904.170062143478, 7948.96025519873, 7962.761117166494, 7976.680932762697, 1999.1203870297022, 2042.4077017664858, 2285.1202287119413, 2304.158981971577, 2324.709411323576, 2363.314638754759, 2364.326167042393, 2373.667686523888, 2375.893084811179, 2378.5718570657273, 2265.4676151104477, 2330.627099664054, 2331.522037982218, 2331.6502524621274, 2334.5214231082587, 2237.686723858661, 2258.062903894882, 2317.7566355532763, 2320.5938960681983, 2321.7578595451437, 2325.5348930214027, 2328.1734984080576, 2338.9532209355716, 2346.6949296591506, 2360.1857359211044, 8046.959765201195, 8092.757217283491, 8113.918860811375, 8117.269445749911, 8126.918730812676, 4871.098846713334, 5001.249812528114, 5043.293938848564, 5043.394792624872, 5044.066847633199, 3053.5267033609825, 3105.813651180936, 3150.9684903150905, 3169.904902852918, 3203.423383790917, 1027.6660085472176, 1864.3567969050655, 1893.810618938109, 1909.7326374307609, 1944.4847115514401, 10851.348919064882, 10962.671119866416, 10990.120790336754, 10994.450277486174, 10996.505157267942, 4309.375140604658, 4350.412694286231, 4428.800703968264, 4430.955690443118, 4465.933011004838, 8852.734417967471, 8867.600957956907, 8882.555872206363, 8888.6000129993, 8907.599158037903, 4919.188333924933, 4950.975245123751, 4978.054169707744, 4981.825636102719, 5002.649814512949, 4517.006258623098, 4559.931601025987, 4607.7004994675235, 4612.469565999886, 4613.123506533748, 3420.521127042216, 3476.652334766503, 3618.203995121069, 3666.7433279670167, 3697.4453831925425, 1151.631477927072, 1153.867305259889, 1159.1943599198644, 1160.808466603001, 1161.8431511745976, 1248.5318005747845, 1270.5299039355314, 1292.9418176182094, 1305.4582348325528, 1306.45129045801, 7172.354488096096, 7175.067241258603, 7427.331540161304, 7593.772186834404, 7605.581693006938, 1078.2991055813627, 1078.5362294213407, 1092.1372116028408, 1104.7845670094255, 1120.1878637987395, 5902.793402230901, 6029.186059881948, 6032.306284777307, 6043.607165534227, 6045.848853778691, 9562.808743825084, 9842.606295748234, 9946.602135914627, 9958.452285124244, 10092.142167915663, 9788.363756355957, 10031.899681003242, 10057.0, 10064.54709538058, 10072.143867771321, 7303.744368947061, 7694.615269236628, 7704.345130663844, 7735.187805280365, 7779.0, 7281.5631062136445, 7395.778126656209, 7419.9258007421395, 7434.628268586657, 7447.478676492594, 8499.57502124879, 8922.509261990393, 8995.0, 8997.865032024394, 9028.638854445748, 8654.697085602225, 8689.652413903626, 8700.0, 8735.956320218358, 8880.955595221982, 6425.5502114851515, 6627.50293727982, 6716.865662686817, 6742.157230346207, 6757.493188011017, 7058.11773528309, 7422.14645315774, 7616.7334143304715, 7625.428092892944, 7629.465937384552, 6795.72817087311, 7011.053507776385, 7115.2884711530505, 7161.534500257467, 7271.200167981412, 6994.125734283215, 7078.0, 7113.2175460698245, 7217.566945983258, 7219.783406497813, 7228.927710722825, 7269.091363579552, 7285.854282914206, 7353.558786472829, 7380.630968451664, 6521.282658907611, 6526.608403495806, 6555.344465553407, 6561.114249576246, 6563.245226798979, 6441.516886233458, 6856.6228857413325, 6907.481938854506, 6908.1019467470915, 6911.861762764616], "unit": "score", "name": "mootools.html", "value": 4662.896983540952}, {"lowerIsBetter": false, "replicates": [337.4583793012215, 346.1933694491834, 350.09500441359086, 351.23430920593114, 351.44998078007916, 5788.305403351593, 5861.2087368205275, 5867.530597552191, 5910.970445147774, 5941.168236446895, 5680.0, 5803.883922321551, 5863.1205319202145, 5866.472017518422, 5878.706064696769, 4579.12996530659, 4586.44962604488, 4590.793414296365, 4597.057603191338, 4598.471175814774, 4358.302671572549, 4456.465224173087, 4474.306482495218, 4562.6121779648765, 4588.77056147193, 4538.500764915857, 4552.931706024412, 4554.590086892179, 4560.612347950429, 4582.77086145693, 4553.840615578455, 4565.589096981254, 4569.086182763461, 4573.908521829578, 4580.633549316047, 4030.576789437096, 4049.2104039712267, 4051.554329023805, 4055.1281474483126, 4059.776712280823, 5382.0, 5522.585806064521, 5529.170624406331, 5534.4742249486235, 5548.306461692288, 5161.5870730341485, 5171.3535808024, 5171.715555644438, 5175.430702622709, 5176.715280659562, 5982.73077711504, 6265.624062556261, 6309.3690630937, 6310.7791227306825, 6314.179156709644, 4245.532991370947, 4280.036991676879, 4371.890702732457, 4375.321825117112, 4376.496702879178, 6397.360263973612, 6504.219493660744, 6507.772227972046, 6509.3490650935, 6519.739210431577, 4465.575770301816, 4469.575390337913, 4476.574725401082, 4477.932831007537, 4479.462464504215, 4409.0, 4478.39541661878, 4533.818647254139, 4537.251353526697, 4544.977380089519, 5186.0, 5250.713575174107, 5252.238425428368, 5255.343082114736, 5256.448072952361, 6321.683915804191, 6321.936780632227, 6326.873462530723, 6330.240371155399, 6332.588381755263, 1585.2786981923198, 1617.6360318928148, 1617.6683779825107, 1618.6681730245507, 1620.9270582823801, 1072.3351522056219, 1077.2459278505078, 1077.7467295185625, 1088.1240601315858, 1105.3367979212408, 5920.319163296276, 5931.4958228550195, 5934.317553481319, 5941.405859414024, 5943.940560594425, 6340.985442329205, 6386.936130638727, 6428.55000149985, 6433.710483028275, 6435.06691529735, 5914.645121292736, 5927.585069045125, 5927.792527261525, 5928.725324055349, 5939.82180534576, 3380.1211684962086, 3476.8783092592143, 3477.1480987158307, 3478.652134786552, 3483.111806489329, 6702.932970670231, 6756.391924726799, 6773.0, 6779.864402711918, 6792.864142717217, 6608.900866487006, 6621.668916554153, 6634.0712300278, 6641.800745977628, 6642.900356494656, 6557.245916719543, 6665.366790154928, 6756.155480564929, 6766.424853887376, 6771.559848609824, 6191.071339299141, 6371.267304260069, 6438.806835794933, 6484.4812415005745, 6489.059086432535, 6314.968425157845, 6492.188476440445, 6495.740170393131, 6513.7068831903625, 6522.0, 6757.662116894234, 6757.729690812313, 6769.120014398097, 6772.93227067723, 6773.559718618274, 4329.935050974301, 4487.394201782718, 4571.931421028621, 4572.45130584332, 4579.290210017452, 6521.380468855451, 6547.869042619026, 6614.867702646016, 6620.040094186413, 6627.271000190071, 6330.430261276507, 6332.430081292706, 6343.52423568225, 6354.0, 6354.872902542016, 6215.223097112861, 6325.462335701517, 6336.081268216175, 6336.841578960563, 6339.587926784744, 6163.075538669235, 6191.349908259568, 6202.596831205957, 6207.596506227081, 6209.937900620936, 6407.295197528175, 6416.615003099829, 6426.839329016812, 6442.90335644975, 6445.2265728112925, 6068.4841788448475, 6187.81436556904, 6206.06908963659, 6214.72033758491, 6231.096491008869], "unit": "score", "name": "prototype.html", "value": 4750.582034253314}, {"lowerIsBetter": false, "replicates": [820.2740574591488, 824.1964085017105, 830.3315830756246, 834.4659417972498, 836.43958547773, 12764.80852787209, 12953.546625868084, 12973.805392919103, 12976.480940762358, 13008.089433739642, 12476.500939962414, 12625.0, 12712.618621441348, 12916.741665166715, 13023.739525209514, 789.2778108031144, 802.7230605441114, 802.743122200896, 804.3806269172734, 804.4409135650695, 659.4724220623506, 668.2115104177069, 784.8979632647748, 793.1275596843484, 798.8082860113589, 832.097174565597, 838.9203025712578, 840.684743221292, 842.0400743152811, 844.1010324004945, 837.1837458477966, 837.3803385494751, 837.9413441059128, 839.1189251286186, 839.8656215005569, 508.35438992479345, 514.4803748214293, 601.2604496469323, 616.6238594457377, 618.060547967092, 13702.794458083137, 13711.177329360271, 13718.0, 13724.862751372459, 13800.861991380058, 12196.329201893892, 12734.872651273461, 12782.360881955865, 12982.675433114153, 13033.218006919615, 10388.272820902539, 10414.166866650725, 10467.790644187073, 10542.947285263524, 11066.889331106666, 3542.3092496963104, 3595.9101022474647, 3641.3445579795625, 3648.0515066083008, 3706.09200745819, 46096.53903460956, 46128.76935615334, 46494.53505464936, 47200.76399618014, 49317.506824931654, 9057.728268151966, 9262.953685231665, 9314.115159059878, 9355.111264429868, 9792.706218813448, 16949.237284322237, 17050.82949170517, 17129.14354282281, 17177.484675459757, 17185.484435466955, 7178.353948144588, 7257.2742725727, 7299.306565876233, 7350.08123984502, 7572.507786993938, 4222.366645003274, 4225.239456897788, 4246.299360605527, 4249.617534421917, 4324.706139849083, 3076.7384772294604, 3105.813651180936, 3113.8598763055716, 3116.719495245439, 3123.2660324823646, 564.0692856786335, 605.1860247966478, 619.6220305613572, 622.1165944359021, 643.276314146585, 541.2233445006428, 565.4712843491349, 622.7820262908036, 628.7013668507514, 677.8779819632415, 7854.646540905673, 8145.978152929493, 8228.465149765367, 8252.381071419668, 8424.28393586552, 502.63810056759075, 519.3508114856429, 603.2459425717852, 614.8555089553952, 637.576011952056, 3981.144054028398, 3984.040048573731, 4087.7547347159266, 4089.8568550100604, 4165.0, 55043.0, 55520.44479555153, 55556.44443555594, 55605.44394556084, 55691.0, 48630.51369486331, 49250.26124608134, 49685.50314496809, 50333.496665033614, 50438.0, 42381.36427953583, 43264.78367608142, 43884.341734874004, 44209.0, 44295.77852110719, 8298.502089874626, 8476.703315384178, 8523.786905327417, 8673.132686731276, 8720.171583699539, 33399.666003339655, 33441.996740097835, 34203.31593368168, 34229.828850855585, 34848.12879677927, 38905.6109438902, 38927.2214555713, 41248.38127428031, 42148.36777448402, 42452.0, 10652.520636571528, 10741.624043158765, 10840.241183117107, 11029.558817647205, 11156.107511398906, 12213.45039473208, 12299.323537205539, 12502.249865008129, 12918.547850825553, 12964.675883102998, 9910.504474776377, 10726.088282495763, 10767.676969690921, 10888.128949684165, 11194.326749020167, 10465.319754215952, 10730.517126729159, 10856.891431085589, 11217.71955701114, 11269.211155219384, 10579.89420105789, 10621.468926553796, 10688.412137332522, 10717.410542420243, 11094.223404361617, 9203.0, 9577.23382129414, 9581.90418095838, 9693.951530242304, 9766.609335626496, 8503.702370417006, 8582.184692454206, 8860.113988601346, 9455.290853185901, 9510.413313191902], "unit": "score", "name": "yui.html", "value": 6142.479637891831}], "name": "dromaeo_css", "value": 6756.114736705533}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 105.0, 109.0, 109.0, 110.0, 110.0, 110.0, 104.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 152.0, 160.0, 127.0, 157.0, 153.0, 133.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 160.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 107.0, 98.0, 74.0, 73.0, 72.0, 117.0, 92.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 151.0, 96.0, 96.0, 95.0, 147.0, 94.0, 97.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 55.0, 54.0, 64.0, 56.0, 56.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [92.0, 83.0, 83.0, 85.0, 86.0, 85.0, 84.0, 85.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 121.0, 119.0, 119.0, 122.0, 128.0, 120.0, 116.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [156.0, 143.0, 155.0, 151.0, 155.0, 146.0, 153.0, 156.0, 152.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 68.0, 71.0, 67.0, 68.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1514.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5306.878306878307], "unit": "score", "name": "Decrypt", "value": 50.15773579262209}, {"lowerIsBetter": false, "replicates": [1962.7450980392157], "unit": "score", "name": "RayTrace", "value": 377.0173726273725}, {"lowerIsBetter": false, "replicates": [797.4481658692185], "unit": "score", "name": "Earley", "value": 835.7446020000003}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [43375.0], "unit": "score", "name": "RegExp", "value": 21.002536023054745}, {"lowerIsBetter": false, "replicates": [555.984555984556], "unit": "score", "name": "Splay", "value": 146.5706180555555}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18965.739537393943}]} 08:12:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18965.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1514.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6756.12"}}} 08:12:44 INFO - Return code: 0 08:12:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:12:44 INFO - # TBPL SUCCESS # 08:12:44 INFO - Running post-action listener: _resource_record_post_action 08:12:44 INFO - Running post-run listener: _resource_record_post_run 08:12:45 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 555601920; Read time: 0; Write time: 561984 08:12:45 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254312448; Read time: 0; Write time: 349032 08:12:45 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 301289472; Read time: 0; Write time: 212952 08:12:45 INFO - Running post-run listener: _upload_blobber_files 08:12:45 INFO - Blob upload gear active. 08:12:45 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:12:45 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 08:12:45 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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:12:45 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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:12:46 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:46 INFO - (blobuploader) - INFO - Done attempting. 08:12:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:47 INFO - (blobuploader) - INFO - Done attempting. 08:12:47 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:47 INFO - Return code: 0 08:12:47 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:12:47 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f1faea7ac63bfc5f52c80e7899ee73ee6951f7e63e8cd7914f5f9be7ca91f4b3820b23a5340943bd0e951e3fe8dd4bc3ca9457f07cf0b180ae3f6152f3b7f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/686e1c2b5aa5a780753dc46e33e8bd33accc489988c34e6662bd6195e45513c2d71d365894e073483472111cee26bfe2c8aeeccbb820824b8f1777a32127857e"} 08:12:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:12:47 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:12:47 INFO - Contents: 08:12:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f1faea7ac63bfc5f52c80e7899ee73ee6951f7e63e8cd7914f5f9be7ca91f4b3820b23a5340943bd0e951e3fe8dd4bc3ca9457f07cf0b180ae3f6152f3b7f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/686e1c2b5aa5a780753dc46e33e8bd33accc489988c34e6662bd6195e45513c2d71d365894e073483472111cee26bfe2c8aeeccbb820824b8f1777a32127857e"} 08:12:47 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:47 INFO - Copying logs to upload dir... 08:12:47 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:12:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.793460 ========= master_lag: 1.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-21 08:12:48.845346) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:48.850308) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f1faea7ac63bfc5f52c80e7899ee73ee6951f7e63e8cd7914f5f9be7ca91f4b3820b23a5340943bd0e951e3fe8dd4bc3ca9457f07cf0b180ae3f6152f3b7f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/686e1c2b5aa5a780753dc46e33e8bd33accc489988c34e6662bd6195e45513c2d71d365894e073483472111cee26bfe2c8aeeccbb820824b8f1777a32127857e"} build_url:https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/bFyw1vruRWeOcwZAhJNlpQ/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/Firefox/sha512/6f1faea7ac63bfc5f52c80e7899ee73ee6951f7e63e8cd7914f5f9be7ca91f4b3820b23a5340943bd0e951e3fe8dd4bc3ca9457f07cf0b180ae3f6152f3b7f01", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/686e1c2b5aa5a780753dc46e33e8bd33accc489988c34e6662bd6195e45513c2d71d365894e073483472111cee26bfe2c8aeeccbb820824b8f1777a32127857e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:48.875843) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:48.876241) ========= 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=33d5923976266a1c518c4bf7000001ab-1453389949.646110-2065556662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 08:12:48.925998) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:12:48.926382) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 08:12:48.926690) ========= ========= Total master_lag: 1.57 =========