builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1453388412.69 results: success (0) buildid: 20160121043138 builduid: 13a83a045dd44a14b957b0586fce196a revision: 977d78a8dd78afbc0153d37fd9887c3a200dce6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.688487) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.688960) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.689248) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005906 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.734310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.734627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.762091) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.762453) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030314 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.812577) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.812849) ========= 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:00:12.813195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.813462) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 07:00:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-01-21 07:00:13 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159853 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.985832) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:12.986169) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077248 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.075707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.076051) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 977d78a8dd78afbc0153d37fd9887c3a200dce6a --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 977d78a8dd78afbc0153d37fd9887c3a200dce6a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 07:00:13,159 truncating revision to first 12 chars 2016-01-21 07:00:13,159 Setting DEBUG logging. 2016-01-21 07:00:13,159 attempt 1/10 2016-01-21 07:00:13,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/977d78a8dd78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 07:00:13,415 unpacking tar archive at: mozilla-central-977d78a8dd78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.533114 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.711494) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.711801) ========= echo 977d78a8dd78afbc0153d37fd9887c3a200dce6a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'977d78a8dd78afbc0153d37fd9887c3a200dce6a'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 977d78a8dd78afbc0153d37fd9887c3a200dce6a program finished with exit code 0 elapsedTime=0.004616 script_repo_revision: '977d78a8dd78afbc0153d37fd9887c3a200dce6a' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.733540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.733814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.744002) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.744251) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/977d78a8dd78afbc0153d37fd9887c3a200dce6a ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-21 07:00:13.744611) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-21 07:00:13.744888) ========= /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=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:13 INFO - MultiFileLogger online at 20160121 07:00:13 in /builds/slave/test-pgo 07:00:13 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:00:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:00:13 INFO - {'append_to_log': False, 07:00:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:00:13 INFO - 'blob_upload_branch': 'Firefox', 07:00:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:00:13 INFO - 'branch': 'Firefox', 07:00:13 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:13 INFO - 'config_files': ('talos/linux_config.py',), 07:00:13 INFO - 'default_actions': ('clobber', 07:00:13 INFO - 'read-buildbot-config', 07:00:13 INFO - 'download-and-extract', 07:00:13 INFO - 'populate-webroot', 07:00:13 INFO - 'create-virtualenv', 07:00:13 INFO - 'install', 07:00:13 INFO - 'run-tests'), 07:00:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:13 INFO - 'download_minidump_stackwalk': True, 07:00:13 INFO - 'download_symbols': 'ondemand', 07:00:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:13 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:13 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:13 INFO - 'installer_path': 'installer.exe', 07:00:13 INFO - 'log_level': 'info', 07:00:13 INFO - 'log_name': 'talos', 07:00:13 INFO - 'log_to_console': True, 07:00:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:13 INFO - 'opt_config_files': (), 07:00:13 INFO - 'pip_index': False, 07:00:13 INFO - 'sps_profile': False, 07:00:13 INFO - 'sps_profile_interval': 0, 07:00:13 INFO - 'suite': 'dromaeojs', 07:00:13 INFO - 'system_bits': '32', 07:00:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:13 INFO - 'title': 'talos-linux64-ix-023', 07:00:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:13 INFO - 'use_talos_json': True, 07:00:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:00:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:13 INFO - 'work_dir': 'build'} 07:00:13 INFO - ##### 07:00:13 INFO - ##### Running clobber step. 07:00:13 INFO - ##### 07:00:13 INFO - Running pre-action listener: _resource_record_pre_action 07:00:13 INFO - Running main action method: clobber 07:00:13 INFO - rmtree: /builds/slave/test-pgo/build 07:00:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:00:17 INFO - Running post-action listener: _resource_record_post_action 07:00:17 INFO - ##### 07:00:17 INFO - ##### Running read-buildbot-config step. 07:00:17 INFO - ##### 07:00:17 INFO - Running pre-action listener: _resource_record_pre_action 07:00:17 INFO - Running main action method: read_buildbot_config 07:00:17 INFO - Using buildbot properties: 07:00:17 INFO - { 07:00:17 INFO - "project": "", 07:00:17 INFO - "product": "firefox", 07:00:17 INFO - "script_repo_revision": "production", 07:00:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:00:17 INFO - "repository": "", 07:00:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:00:17 INFO - "buildid": "20160121043138", 07:00:17 INFO - "pgo_build": "True", 07:00:17 INFO - "basedir": "/builds/slave/test-pgo", 07:00:17 INFO - "buildnumber": 316, 07:00:17 INFO - "slavename": "talos-linux64-ix-023", 07:00:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:00:17 INFO - "platform": "ubuntu64_hw", 07:00:17 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:00:17 INFO - "branch": "mozilla-central", 07:00:17 INFO - "repo_path": "mozilla-central", 07:00:17 INFO - "revision": "977d78a8dd78afbc0153d37fd9887c3a200dce6a", 07:00:17 INFO - "stage_platform": "linux64-pgo", 07:00:17 INFO - "builduid": "13a83a045dd44a14b957b0586fce196a", 07:00:17 INFO - "slavebuilddir": "test" 07:00:17 INFO - } 07:00:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:00:17 INFO - Running post-action listener: _resource_record_post_action 07:00:17 INFO - ##### 07:00:17 INFO - ##### Running download-and-extract step. 07:00:17 INFO - ##### 07:00:17 INFO - Running pre-action listener: _resource_record_pre_action 07:00:17 INFO - Running main action method: download_and_extract 07:00:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:17 INFO - https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/test_packages.json 07:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/test_packages.json 07:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:00:18 INFO - Downloaded 1448 bytes. 07:00:18 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:00:18 INFO - Using the following test package requirements: 07:00:18 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:18 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:18 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:18 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'jsshell-linux-x86_64.zip'], 07:00:18 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:18 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:18 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:18 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:18 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:18 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:18 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:18 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:18 INFO - https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:20 INFO - Downloaded 22486661 bytes. 07:00:20 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:00:20 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:00:21 INFO - Return code: 0 07:00:21 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:00:21 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:00:21 INFO - https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:25 INFO - Downloaded 22486661 bytes. 07:00:25 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:00:25 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:00:27 INFO - Return code: 0 07:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:27 INFO - https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:28 INFO - Downloaded 10705515 bytes. 07:00:28 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:00:28 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:00:28 INFO - Return code: 0 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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:00:45 INFO - Downloaded 55962394 bytes. 07:00:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:00:45 INFO - mkdir: /builds/slave/test-pgo/properties 07:00:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:00:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:00:45 INFO - Contents: 07:00:45 INFO - build_url:https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:00:45 INFO - Running post-action listener: _resource_record_post_action 07:00:45 INFO - Running post-action listener: set_extra_try_arguments 07:00:45 INFO - ##### 07:00:45 INFO - ##### Running populate-webroot step. 07:00:45 INFO - ##### 07:00:45 INFO - Running pre-action listener: _resource_record_pre_action 07:00:45 INFO - Running main action method: populate_webroot 07:00:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:45 INFO - '--tppagecycles', 07:00:45 INFO - '7'], 07:00:45 INFO - 'tests': ['tsvgm']}}, 07:00:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:00:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:00:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:00:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'tests': ['damp', 'tps']}, 07:00:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['damp', 'tps']}, 07:00:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:00:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:45 INFO - 'other': {'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'other_l64': {'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'other_nol64': {'tests': ['a11yr', 07:00:45 INFO - 'ts_paint', 07:00:45 INFO - 'tpaint', 07:00:45 INFO - 'sessionrestore', 07:00:45 INFO - 'sessionrestore_no_auto_restore']}, 07:00:45 INFO - 'svgr': {'tests': ['tsvgx', 07:00:45 INFO - 'tsvgr_opacity', 07:00:45 INFO - 'tart', 07:00:45 INFO - 'tscrollx', 07:00:45 INFO - 'cart']}, 07:00:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['tsvgx', 07:00:45 INFO - 'tsvgr_opacity', 07:00:45 INFO - 'tart', 07:00:45 INFO - 'tscrollx', 07:00:45 INFO - 'cart']}, 07:00:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'tests': ['tp5o']}, 07:00:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'talos_options': ['--e10s'], 07:00:45 INFO - 'tests': ['tp5o']}, 07:00:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'talos_options': ['--xperf_path', 07:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:45 INFO - 'tests': ['tp5n']}, 07:00:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:45 INFO - 'talos_options': ['--e10s', 07:00:45 INFO - '--xperf_path', 07:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:45 INFO - 'tests': ['tp5n']}}, 07:00:45 INFO - 'talos.zip': {'path': '', 07:00:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:45 INFO - Running post-action listener: _resource_record_post_action 07:00:45 INFO - ##### 07:00:45 INFO - ##### Running create-virtualenv step. 07:00:45 INFO - ##### 07:00:45 INFO - Running pre-action listener: _resource_record_pre_action 07:00:45 INFO - Running main action method: create_virtualenv 07:00:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:00:45 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:00:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:00:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:45 INFO - Using real prefix '/usr' 07:00:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:00:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:48 INFO - Installing pip.................done. 07:00:48 INFO - Return code: 0 07:00:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:00: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:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:48 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:48 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:00:48 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:00:48 INFO - Using env: {'DISPLAY': ':0', 07:00:48 INFO - 'HOME': '/home/cltbld', 07:00:48 INFO - 'LANG': 'en_US.UTF-8', 07:00:48 INFO - 'LANGUAGE': 'en_US:en', 07:00:48 INFO - 'LOGNAME': 'cltbld', 07:00:48 INFO - 'MAIL': '/var/mail/cltbld', 07:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:48 INFO - 'MOZ_NO_REMOTE': '1', 07:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:48 INFO - 'NO_EM_RESTART': '1', 07:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:48 INFO - 'SHELL': '/bin/bash', 07:00:48 INFO - 'SHLVL': '1', 07:00:48 INFO - 'TERM': 'linux', 07:00:48 INFO - 'TMOUT': '86400', 07:00:48 INFO - 'USER': 'cltbld', 07:00:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:48 INFO - '_': '/tools/buildbot/bin/python'} 07:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:00:48 INFO - Cleaning up... 07:00:48 INFO - Return code: 0 07:00:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:00: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:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:48 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:48 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:00:48 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:00:48 INFO - Using env: {'DISPLAY': ':0', 07:00:48 INFO - 'HOME': '/home/cltbld', 07:00:48 INFO - 'LANG': 'en_US.UTF-8', 07:00:48 INFO - 'LANGUAGE': 'en_US:en', 07:00:48 INFO - 'LOGNAME': 'cltbld', 07:00:48 INFO - 'MAIL': '/var/mail/cltbld', 07:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:48 INFO - 'MOZ_NO_REMOTE': '1', 07:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:48 INFO - 'NO_EM_RESTART': '1', 07:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:48 INFO - 'SHELL': '/bin/bash', 07:00:48 INFO - 'SHLVL': '1', 07:00:48 INFO - 'TERM': 'linux', 07:00:48 INFO - 'TMOUT': '86400', 07:00:48 INFO - 'USER': 'cltbld', 07:00:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:48 INFO - '_': '/tools/buildbot/bin/python'} 07:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:48 INFO - Downloading/unpacking psutil>=0.7.1 07:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:50 INFO - Installing collected packages: psutil 07:00:50 INFO - Running setup.py install for psutil 07:00:50 INFO - building 'psutil._psutil_linux' extension 07:00:50 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:00:50 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:00:50 INFO - building 'psutil._psutil_posix' extension 07:00:50 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:00:50 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:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:50 INFO - Successfully installed psutil 07:00:50 INFO - Cleaning up... 07:00:51 INFO - Return code: 0 07:00:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:51 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:51 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:00:51 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:00:51 INFO - Using env: {'DISPLAY': ':0', 07:00:51 INFO - 'HOME': '/home/cltbld', 07:00:51 INFO - 'LANG': 'en_US.UTF-8', 07:00:51 INFO - 'LANGUAGE': 'en_US:en', 07:00:51 INFO - 'LOGNAME': 'cltbld', 07:00:51 INFO - 'MAIL': '/var/mail/cltbld', 07:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:51 INFO - 'MOZ_NO_REMOTE': '1', 07:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:51 INFO - 'NO_EM_RESTART': '1', 07:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:51 INFO - 'SHELL': '/bin/bash', 07:00:51 INFO - 'SHLVL': '1', 07:00:51 INFO - 'TERM': 'linux', 07:00:51 INFO - 'TMOUT': '86400', 07:00:51 INFO - 'USER': 'cltbld', 07:00:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:51 INFO - '_': '/tools/buildbot/bin/python'} 07:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:53 INFO - Installing collected packages: mozsystemmonitor 07:00:53 INFO - Running setup.py install for mozsystemmonitor 07:00:53 INFO - Successfully installed mozsystemmonitor 07:00:53 INFO - Cleaning up... 07:00:53 INFO - Return code: 0 07:00:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:53 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:53 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:00:53 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:00:53 INFO - Using env: {'DISPLAY': ':0', 07:00:53 INFO - 'HOME': '/home/cltbld', 07:00:53 INFO - 'LANG': 'en_US.UTF-8', 07:00:53 INFO - 'LANGUAGE': 'en_US:en', 07:00:53 INFO - 'LOGNAME': 'cltbld', 07:00:53 INFO - 'MAIL': '/var/mail/cltbld', 07:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:53 INFO - 'MOZ_NO_REMOTE': '1', 07:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:53 INFO - 'NO_EM_RESTART': '1', 07:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:53 INFO - 'SHELL': '/bin/bash', 07:00:53 INFO - 'SHLVL': '1', 07:00:53 INFO - 'TERM': 'linux', 07:00:53 INFO - 'TMOUT': '86400', 07:00:53 INFO - 'USER': 'cltbld', 07:00:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:53 INFO - '_': '/tools/buildbot/bin/python'} 07:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:55 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:00:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:55 INFO - Downloading docopt-0.6.1.tar.gz 07:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:55 INFO - Running setup.py install for blobuploader 07:00:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:00:56 INFO - Running setup.py install for requests 07:00:56 INFO - Running setup.py install for docopt 07:00:56 INFO - Successfully installed blobuploader requests docopt 07:00:56 INFO - Cleaning up... 07:00:56 INFO - Return code: 0 07:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:56 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:56 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:00:56 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:00:56 INFO - Using env: {'DISPLAY': ':0', 07:00:56 INFO - 'HOME': '/home/cltbld', 07:00:56 INFO - 'LANG': 'en_US.UTF-8', 07:00:56 INFO - 'LANGUAGE': 'en_US:en', 07:00:56 INFO - 'LOGNAME': 'cltbld', 07:00:56 INFO - 'MAIL': '/var/mail/cltbld', 07:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:56 INFO - 'MOZ_NO_REMOTE': '1', 07:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:56 INFO - 'NO_EM_RESTART': '1', 07:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:56 INFO - 'SHELL': '/bin/bash', 07:00:56 INFO - 'SHLVL': '1', 07:00:56 INFO - 'TERM': 'linux', 07:00:56 INFO - 'TMOUT': '86400', 07:00:56 INFO - 'USER': 'cltbld', 07:00:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:56 INFO - '_': '/tools/buildbot/bin/python'} 07:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:56 INFO - Running setup.py (path:/tmp/pip-WAIn_t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:56 INFO - Running setup.py (path:/tmp/pip-XyJDNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:56 INFO - Running setup.py (path:/tmp/pip-p8uLXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:56 INFO - Running setup.py (path:/tmp/pip-YElHw4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:57 INFO - Running setup.py (path:/tmp/pip-mZ3tfQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:57 INFO - Running setup.py (path:/tmp/pip-Z2vBb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:57 INFO - Running setup.py (path:/tmp/pip-22IH3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:57 INFO - Running setup.py (path:/tmp/pip-GrBTgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:57 INFO - Running setup.py (path:/tmp/pip-nAZhwv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:57 INFO - Running setup.py (path:/tmp/pip-wwkSts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:57 INFO - Running setup.py (path:/tmp/pip-QAiVSP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:57 INFO - Running setup.py (path:/tmp/pip-EjMDnF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:57 INFO - Running setup.py (path:/tmp/pip-Df1JwC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:57 INFO - Running setup.py (path:/tmp/pip-jMSx2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:57 INFO - Running setup.py (path:/tmp/pip-j3xXr9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:57 INFO - Running setup.py (path:/tmp/pip-nnbla0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:57 INFO - Running setup.py (path:/tmp/pip-nlc_Bn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:57 INFO - Running setup.py install for manifestparser 07:00:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for mozcrash 07:00:58 INFO - Running setup.py install for mozdebug 07:00:58 INFO - Running setup.py install for mozdevice 07:00:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for mozfile 07:00:58 INFO - Running setup.py install for mozhttpd 07:00:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for mozinfo 07:00:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for mozInstall 07:00:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for mozleak 07:00:58 INFO - Running setup.py install for mozlog 07:00:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:00:58 INFO - Running setup.py install for moznetwork 07:00:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Running setup.py install for mozprocess 07:00:59 INFO - Running setup.py install for mozprofile 07:00:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Running setup.py install for mozrunner 07:00:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Running setup.py install for mozscreenshot 07:00:59 INFO - Running setup.py install for moztest 07:00:59 INFO - Running setup.py install for mozversion 07:00:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:00:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:59 INFO - Cleaning up... 07:00:59 INFO - Return code: 0 07:00:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00: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:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:59 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:00:59 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:00:59 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:00:59 INFO - Using env: {'DISPLAY': ':0', 07:00:59 INFO - 'HOME': '/home/cltbld', 07:00:59 INFO - 'LANG': 'en_US.UTF-8', 07:00:59 INFO - 'LANGUAGE': 'en_US:en', 07:00:59 INFO - 'LOGNAME': 'cltbld', 07:00:59 INFO - 'MAIL': '/var/mail/cltbld', 07:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:59 INFO - 'MOZ_NO_REMOTE': '1', 07:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:59 INFO - 'NO_EM_RESTART': '1', 07:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:59 INFO - 'SHELL': '/bin/bash', 07:00:59 INFO - 'SHLVL': '1', 07:00:59 INFO - 'TERM': 'linux', 07:00:59 INFO - 'TMOUT': '86400', 07:00:59 INFO - 'USER': 'cltbld', 07:00:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:59 INFO - '_': '/tools/buildbot/bin/python'} 07:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:59 INFO - Running setup.py (path:/tmp/pip-W1Talo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:59 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:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:59 INFO - Running setup.py (path:/tmp/pip-bfq42X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:00 INFO - Running setup.py (path:/tmp/pip-rDuk4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:00 INFO - Running setup.py (path:/tmp/pip-Gyy8eh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:00 INFO - Running setup.py (path:/tmp/pip-dnp_6O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:00 INFO - Running setup.py (path:/tmp/pip-uc_bzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:00 INFO - Running setup.py (path:/tmp/pip-53yyZm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:00 INFO - Running setup.py (path:/tmp/pip-CFkaXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 07:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:00 INFO - Running setup.py (path:/tmp/pip-DFlTCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:00 INFO - Running setup.py (path:/tmp/pip-slYYFc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:00 INFO - Running setup.py (path:/tmp/pip-iWdYAp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:00 INFO - Running setup.py (path:/tmp/pip-oDzygv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:00 INFO - Running setup.py (path:/tmp/pip-yEFkHu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:00 INFO - Running setup.py (path:/tmp/pip-YfUseH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:00 INFO - Running setup.py (path:/tmp/pip-WxPtBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:01:00 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:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:00 INFO - Running setup.py (path:/tmp/pip-QwRshM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 07:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:01 INFO - Running setup.py (path:/tmp/pip-OW4Yqk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:01: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:01: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:01: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:01: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:01: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:01: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:01:03 INFO - Downloading blessings-1.6.tar.gz 07:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:01:03 INFO - Installing collected packages: blessings 07:01:03 INFO - Running setup.py install for blessings 07:01:03 INFO - Successfully installed blessings 07:01:03 INFO - Cleaning up... 07:01:03 INFO - Return code: 0 07:01:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:01:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:01:03 INFO - Reading from file tmpfile_stdout 07:01:03 INFO - Current package versions: 07:01:03 INFO - argparse == 1.2.1 07:01:03 INFO - blessings == 1.6 07:01:03 INFO - blobuploader == 1.2.4 07:01:03 INFO - docopt == 0.6.1 07:01:03 INFO - manifestparser == 1.1 07:01:03 INFO - mozInstall == 1.12 07:01:03 INFO - mozcrash == 0.16 07:01:03 INFO - mozdebug == 0.1 07:01:03 INFO - mozdevice == 0.48 07:01:03 INFO - mozfile == 1.2 07:01:03 INFO - mozhttpd == 0.7 07:01:03 INFO - mozinfo == 0.9 07:01:03 INFO - mozleak == 0.1 07:01:03 INFO - mozlog == 3.1 07:01:03 INFO - moznetwork == 0.27 07:01:03 INFO - mozprocess == 0.22 07:01:03 INFO - mozprofile == 0.28 07:01:03 INFO - mozrunner == 6.11 07:01:03 INFO - mozscreenshot == 0.1 07:01:03 INFO - mozsystemmonitor == 0.0 07:01:03 INFO - moztest == 0.7 07:01:03 INFO - mozversion == 1.4 07:01:03 INFO - psutil == 3.1.1 07:01:03 INFO - requests == 1.2.3 07:01:03 INFO - wsgiref == 0.1.2 07:01:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:03 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:01:03 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:01:03 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:01:03 INFO - Using env: {'DISPLAY': ':0', 07:01:03 INFO - 'HOME': '/home/cltbld', 07:01:03 INFO - 'LANG': 'en_US.UTF-8', 07:01:03 INFO - 'LANGUAGE': 'en_US:en', 07:01:03 INFO - 'LOGNAME': 'cltbld', 07:01:03 INFO - 'MAIL': '/var/mail/cltbld', 07:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:03 INFO - 'MOZ_NO_REMOTE': '1', 07:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:03 INFO - 'NO_EM_RESTART': '1', 07:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:03 INFO - 'SHELL': '/bin/bash', 07:01:03 INFO - 'SHLVL': '1', 07:01:03 INFO - 'TERM': 'linux', 07:01:03 INFO - 'TMOUT': '86400', 07:01:03 INFO - 'USER': 'cltbld', 07:01:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:03 INFO - '_': '/tools/buildbot/bin/python'} 07:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 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:01:03 INFO - Cleaning up... 07:01:03 INFO - Return code: 0 07:01:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:03 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:01:03 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:01:03 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:01:03 INFO - Using env: {'DISPLAY': ':0', 07:01:03 INFO - 'HOME': '/home/cltbld', 07:01:03 INFO - 'LANG': 'en_US.UTF-8', 07:01:03 INFO - 'LANGUAGE': 'en_US:en', 07:01:03 INFO - 'LOGNAME': 'cltbld', 07:01:03 INFO - 'MAIL': '/var/mail/cltbld', 07:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:03 INFO - 'MOZ_NO_REMOTE': '1', 07:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:03 INFO - 'NO_EM_RESTART': '1', 07:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:03 INFO - 'SHELL': '/bin/bash', 07:01:03 INFO - 'SHLVL': '1', 07:01:03 INFO - 'TERM': 'linux', 07:01:03 INFO - 'TMOUT': '86400', 07:01:03 INFO - 'USER': 'cltbld', 07:01:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:03 INFO - '_': '/tools/buildbot/bin/python'} 07:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:03 INFO - Downloading/unpacking jsonschema 07:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:05 INFO - Downloading/unpacking functools32 (from jsonschema) 07:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:05 INFO - warning: no files found matching '*.txt' 07:01:05 INFO - no previously-included directories found matching 'build' 07:01:05 INFO - no previously-included directories found matching 'dist' 07:01:05 INFO - no previously-included directories found matching '.git*' 07:01:05 INFO - Installing collected packages: jsonschema, functools32 07:01:06 INFO - Running setup.py install for functools32 07:01:06 INFO - warning: no files found matching '*.txt' 07:01:06 INFO - no previously-included directories found matching 'build' 07:01:06 INFO - no previously-included directories found matching 'dist' 07:01:06 INFO - no previously-included directories found matching '.git*' 07:01:06 INFO - Successfully installed jsonschema functools32 07:01:06 INFO - Cleaning up... 07:01:06 INFO - Return code: 0 07:01:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:06 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 0x7fd068fbff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e228a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', '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:01:06 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:01:06 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:01:06 INFO - Using env: {'DISPLAY': ':0', 07:01:06 INFO - 'HOME': '/home/cltbld', 07:01:06 INFO - 'LANG': 'en_US.UTF-8', 07:01:06 INFO - 'LANGUAGE': 'en_US:en', 07:01:06 INFO - 'LOGNAME': 'cltbld', 07:01:06 INFO - 'MAIL': '/var/mail/cltbld', 07:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:06 INFO - 'MOZ_NO_REMOTE': '1', 07:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:06 INFO - 'NO_EM_RESTART': '1', 07:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:06 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:06 INFO - 'SHELL': '/bin/bash', 07:01:06 INFO - 'SHLVL': '1', 07:01:06 INFO - 'TERM': 'linux', 07:01:06 INFO - 'TMOUT': '86400', 07:01:06 INFO - 'USER': 'cltbld', 07:01:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:06 INFO - '_': '/tools/buildbot/bin/python'} 07:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:06 INFO - Downloading/unpacking flake8 07:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:08 INFO - no previously-included directories found matching 'docs/_build' 07:01:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:08 INFO - Running setup.py install for pep8 07:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:08 INFO - no previously-included directories found matching 'docs/_build' 07:01:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:01:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:09 INFO - Cleaning up... 07:01:09 INFO - Return code: 0 07:01:09 INFO - Running post-action listener: _resource_record_post_action 07:01:09 INFO - Running post-action listener: _start_resource_monitoring 07:01:09 INFO - Starting resource monitoring. 07:01:09 INFO - ##### 07:01:09 INFO - ##### Running install step. 07:01:09 INFO - ##### 07:01:09 INFO - Running pre-action listener: _resource_record_pre_action 07:01:09 INFO - Running main action method: install 07:01:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:01:09 INFO - Reading from file tmpfile_stdout 07:01:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:01:09 INFO - Reading from file tmpfile_stdout 07:01:09 INFO - Output received: 07:01:09 INFO - Usage: mozinstall [options] installer 07:01:09 INFO - Options: 07:01:09 INFO - -h, --help show this help message and exit 07:01:09 INFO - -d DEST, --destination=DEST 07:01:09 INFO - Directory to install application into. [default: 07:01:09 INFO - "/builds/slave/test-pgo"] 07:01:09 INFO - --app=APP Application being installed. [default: firefox] 07:01:09 INFO - mkdir: /builds/slave/test-pgo/build/application 07:01:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:01:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:01:25 INFO - Reading from file tmpfile_stdout 07:01:25 INFO - Output received: 07:01:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:01:25 INFO - Running post-action listener: _resource_record_post_action 07:01:25 INFO - ##### 07:01:25 INFO - ##### Running run-tests step. 07:01:25 INFO - ##### 07:01:25 INFO - Running pre-action listener: _resource_record_pre_action 07:01:25 INFO - Running main action method: run_tests 07:01:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:01:25 INFO - Python 2.7.3 07:01:25 INFO - Return code: 0 07:01:25 INFO - grabbing minidump binary from tooltool 07:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f83840>, '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 0x1ef06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:01:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 07:01:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:01:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:25 INFO - Return code: 0 07:01:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:01:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:01:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:01:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:01:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:01:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:01:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:01:26 INFO - Return code: 0 07:01:26 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/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:01:26 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/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:01:26 INFO - Using env: {'DISPLAY': ':0', 07:01:26 INFO - 'HOME': '/home/cltbld', 07:01:26 INFO - 'LANG': 'en_US.UTF-8', 07:01:26 INFO - 'LANGUAGE': 'en_US:en', 07:01:26 INFO - 'LOGNAME': 'cltbld', 07:01:26 INFO - 'MAIL': '/var/mail/cltbld', 07:01:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:01:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:26 INFO - 'MOZ_NO_REMOTE': '1', 07:01:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:26 INFO - 'NO_EM_RESTART': '1', 07:01:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:01:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:01:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:01:26 INFO - 'SHELL': '/bin/bash', 07:01:26 INFO - 'SHLVL': '1', 07:01:26 INFO - 'TERM': 'linux', 07:01:26 INFO - 'TMOUT': '86400', 07:01:26 INFO - 'USER': 'cltbld', 07:01:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387', 07:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:26 INFO - '_': '/tools/buildbot/bin/python'} 07:01:26 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/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:01:26 INFO - mozversion application_buildid: 20160121043138 07:01:26 INFO - mozversion application_changeset: 977d78a8dd78afbc0153d37fd9887c3a200dce6a 07:01:26 INFO - mozversion application_display_name: Nightly 07:01:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:26 INFO - mozversion application_name: Firefox 07:01:26 INFO - mozversion application_remotingname: firefox 07:01:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:01:26 INFO - mozversion application_vendor: Mozilla 07:01:26 INFO - mozversion application_version: 46.0a1 07:01:26 INFO - mozversion platform_buildid: 20160121043138 07:01:26 INFO - mozversion platform_changeset: 977d78a8dd78afbc0153d37fd9887c3a200dce6a 07:01:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:01:26 INFO - mozversion platform_version: 46.0a1 07:01:26 INFO - using testdate: 1453388486 07:01:26 INFO - actual date: 1453388486 07:01:26 INFO - starting webserver on 'localhost:37509' 07:01:26 INFO - SUITE-START | Running 3 tests 07:01:26 INFO - TEST-START | dromaeo_css 07:01:26 INFO - operating with platform_type : linux_ 07:01:26 INFO - Initialising browser for dromaeo_css test... 07:01:26 INFO - TEST-INFO | started process 3639 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfV1Td1/profile http://localhost:37509/getInfo.html) 07:01:30 INFO - PROCESS | 3639 | __metrics Screen width/height:1600/1200 07:01:30 INFO - PROCESS | 3639 | colorDepth:24 07:01:30 INFO - PROCESS | 3639 | Browser inner width/height: 1024/697 07:01:30 INFO - PROCESS | 3639 | __metrics 07:01:30 INFO - PROCESS | 3639 | 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:01:30 INFO - PROCESS | 3639 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:01:31 INFO - TEST-INFO | 3639: exit 0 07:01:31 INFO - Browser initialized. 07:01:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:31 INFO - TEST-INFO | started process 3733 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfV1Td1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:43 INFO - PROCESS | 3733 | RSS: Main: 148856832 07:01:43 INFO - PROCESS | 3733 | 07:02:34 INFO - PROCESS | 3733 | 1453388554370 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:04:43 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37509/tests/dromaeo/cssquery-ext.html) 07:04:44 INFO - PROCESS | 3733 | RSS: Main: 269664256 07:04:44 INFO - PROCESS | 3733 | 07:07:46 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-ext.html (next: http://localhost:37509/tests/dromaeo/cssquery-jquery.html) 07:07:47 INFO - PROCESS | 3733 | RSS: Main: 227946496 07:07:47 INFO - PROCESS | 3733 | 07:10:49 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37509/tests/dromaeo/cssquery-mootools.html) 07:10:49 INFO - PROCESS | 3733 | RSS: Main: 224608256 07:10:49 INFO - PROCESS | 3733 | 07:13:51 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37509/tests/dromaeo/cssquery-prototype.html) 07:13:52 INFO - PROCESS | 3733 | RSS: Main: 204746752 07:13:52 INFO - PROCESS | 3733 | 07:16:55 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37509/tests/dromaeo/cssquery-yui.html) 07:16:55 INFO - PROCESS | 3733 | RSS: Main: 208912384 07:16:55 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | Cycle 1(1): loaded http://localhost:37509/tests/dromaeo/cssquery-yui.html (next: http://localhost:37509/tests/dromaeo/cssquery-dojo.html) 07:19:58 INFO - PROCESS | 3733 | RSS: Main: 267534336 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | __start_tp_report 07:19:58 INFO - PROCESS | 3733 | _x_x_mozilla_page_load 07:19:58 INFO - PROCESS | 3733 | _x_x_mozilla_page_load_details 07:19:58 INFO - PROCESS | 3733 | |i|pagename|runs| 07:19:58 INFO - PROCESS | 3733 | |0;dojo.html;3157.731592814611;3168;3217.662145474725;3225.1453364858303;3245.3671534050854;5047.924281135786;5106.183010718277;5200.115980283352;5204.671393672171;5255.527002569768;5197.272381866542;5198.532132108109;5215.295935048767;5219.45195754446;5245.79016839327;4697.694649847766;4726.385569875912;4730.597899178574;4787;4826.7827947742435;4736.100140973222;4749.287606858981;4767.785449654774;4803.3515475410895;4814.566688997989;4645.605123564467;4665.0669866026765;4715.457722361938;4722.456917454502;4738.478767335608;4681.133990211822;4686.156491831469;4687.2969054641735;4693.9765301173275;4723.598494128003;4673.556012178838;4678.251479763256;4679.110968915895;4682.484926658065;4722.858314250578;4913.656044076916;4945.109880221558;4969.031038947407;5020.146575082208;5033.899322013539;5461.481159289861;5473.75368108436;5474.808381706661;5480.314960629921;5489.505944464978;5453.209284653703;5495.6153069285165;5500.119980803092;5518.475744804237;5544.91682624761;5147.22791581262;5166.225066240057;5175.818846340398;5178.637495375363;5202.453742357074;5658.151277308437;5659.801906933238;5659.801906933238;5665.5184309333345;5679.545636349082;5390.19147127934;5432.728363581805;5448.291722076105;5453.263809385761;5453.672779633234;5466.9179962300595;5498.45015498447;5610.270664813548;5625.353084395265;5647.971760141173;5513.669179849222;5517.668939863541;5522.061249587579;5523.061079616475;5530.944690553043;5462.481064298885;5500.779968801203;5507.944920550824;5517.806876759294;5557.944420555824;4289.849855255051;4311.935320970188;4327.978360108179;4344.739315641072;4357.542458041923;3866.2654095721723;3881.8835434936996;3895.824687888995;3922.7450215735885;3936.586658400884;5199.818006369759;5206.271122042917;5213;5216.556592689588;5248.448912864094;5513.255710479034;5556.388797232301;5590.91613625796;5601.215829783833;5626.521745651666;5192.169252919514;5226.608004399685;5228.137357335997;5229.6600720953775;5232.319798426181;4703.811847526129;4781.784819683123;4784.138855006063;4784.282357646381;4833.854984350475;5743.712814359265;5771.192033115367;5785.363610002896;5819.301683797971;5863.355030946593;5572.665640061609;5578.023845827045;5580.693061881636;5581.441855814386;5587.636803607753;5749.91375129365;5795.420457954171;5803.448672376117;5806.361300256884;5806.738696758741;5425.891482170256;5464.262324586289;5468.726563671721;5468.972655136698;5515.255440515479;5521.5306698929435;5560.527355174855;5576.86057848557;5577.498025177753;5582.888342233214;5336.359636843604;5346.385165705994;5422.295101636762;5435.83692489226;5453.7818487260065;5462.508374246337;5464.1257398816;5471.8084867029465;5473.397926228191;5492.80775172867;5352.250684904038;5366.865828354323;5372.892542149057;5381.784728610812;5436.320459942507;5368.979893820162;5386.649867758583;5419.34967803866;5431.8098866539485;5472.151816468454;5415.1335786274;5417.512423881712;5421.9186712200135;5427.728613569227;5437.293151890387 07:19:58 INFO - PROCESS | 3733 | |1;ext.html;516.1148630099381;551.1759918921214;573.3233709851493;613.3774219167544;616.747133675193;36551;37088.629113708856;37128.62871371285;37152.44271335932;37190.814045929765;40475.19049619006;41053;41056.58943410565;41107.38338924918;41120.177596448055;8326.666933322675;8501.744947651581;8516.74449766505;8528.78678033048;8534.317254619615;8205.917940820606;8265.876011859827;8325.209105135002;8509.61706723199;8516.957415212915;8524.8721269181;8597.18326758957;8607.569621518931;8609.26821220197;8617.353698472609;8478.109798471165;8548.529830859301;8552.828943421127;8558.957205213965;8591.785205369915;8364.58177091143;8480.830383392298;8488.066312705598;8490.872636910452;8492.193241642035;39941;40414.59585404138;40427.797861010804;40428;40429.79785101085;3274.590676165479;3491.0050635568996;3665.7433979621437;3925.2738243425056;3955.4857868476915;30050.24874378136;30302.393952121056;30679.2330191747;30717.62106168342;30729;3899.6685281751083;3904.39481880309;3955.46601208836;4004.619561141687;4009.4386785850006;252037.6583053767;252739.41781746576;252891;253387.73306133537;254012;58054.70972645194;58316;58380.7080964601;58393.70803146042;58433.41566584365;62439;62677.35903768683;62834.68582657149;62896.68551657212;62934;15241.466548670744;15395.07629542231;15415.229238538253;15429.459968901034;15439.150846703315;11401.828972565418;11509.827352589718;11526.135539834546;11542.59600913964;11569.305841649528;18735.757211834152;19715.901420492806;19751.506212344808;19865.503362416057;19919.302824401075;6021.849453763691;7426.517276377126;7519.624018799038;7582.165961744204;8032.236937490929;895.8253140637644;1010.5604062232952;1010.696790962723;1015.817152912468;1049.2031525819755;26613.866930665223;29325.413491730047;29608.703912960595;30456.238594034883;30504.237394064883;1010.2120346130031;1011.9291649584605;1046.6284469013542;1075.8440026196315;1148.2823235477827;13771.793423098661;13800;14058.086224395382;14431.340395854611;14516.274186290855;300431;301891;428227;428427;435945;52165.73917130466;52848.20727689088;52967.20549191765;53053.204201937;53167.46832531702;1275.8277632519678;1285.1261142423054;1287.6909541710108;1288.6134159752037;1291.9935400322938;25055.624165637895;25628.871855641348;29082.56376154317;29371.265718357212;29842.104736857927;48027;48184.75907620439;48249.758751207424;48269;48301;241995;242841;243173;243515;243566;31033.844830775703;31343.68656313499;31697.366052678357;31720.524192137596;32099.67900320967;40443.1911361777;40606.79696601498;41103.38344924888;41114;41213;34911.476327854594;35259.64740352564;36367.27265454729;36833;37320.81339593285;35777.28445431129;35894.461583075754;36077.81961090178;36725;36907.44638830366;34728.65271347254;35721.46417803683;35729.64270357367;35743;35777.46333805047;29663.85168074146;32542.83728581342;32874.17814554655;32972.83513582417;33091.172720682174;24945.251642450756;25977.220683379528;32899.67100328966;33389.49915751217;33427.164320892174 07:19:58 INFO - PROCESS | 3733 | |2;jquery.html;364.5825529768414;367.5662717992768;369.2817470020809;370.06189310098904;370.8294184675049;13461.326933653327;13549.864501354983;15478.148701821396;16854.49436516905;17872.106394680246;15346.616334591612;15786.605334866634;15811.130387828665;15915.44295949642;16998.235079421425;4928.605711543077;5461.672299662033;5465.699386533739;5468;5470.343558772953;4022.376531637586;4121.896952576195;5348.46515348464;5454.7818087276655;5707.429257074301;5658.773649054054;5785.247917770684;5867.207926929874;5868.882622347551;5871.530277577784;5940.97029514854;5990.131430942489;6010.489108425789;6015.909761353583;6016.067509536029;4962.206047032458;5178.585713142939;5179.611529135293;5299.6025298102795;5299.867503312409;18273;18520.629587408177;18730.531736706693;18925.810741892543;18973.335933242408;2012.6578481658007;2042.2137477071285;2095.1828786773017;2185.7595664476894;2219.6448568229166;9000.819983600357;9261.536923153815;9286.767830804216;9424.670136545188;9729.173020293283;1699.600593860442;1700.1074435921116;1700.523853321072;1716.6223430845193;1723.8017627972818;56232.43767562313;56697.716511417595;56859;57481.42518574803;57864.71067644677;9930.950345248228;10070.144037756727;10111.292209545261;10139.7465063374;10186.185105191567;13171.934140329236;13271.137376070525;13330.066895317235;13333.20000799955;13371.197728136343;7358.77923662291;7388.408927285805;7398.630068496554;7438.962805185939;7463;7026.156861176692;7028.121484814398;7074.434045276365;7095;7095.184053833772;4408.647308215399;4479.193745125844;4486.080353527519;4518.977405112953;4521.502634710179;1717.6822287876782;1775.6537475192472;1801.5135913303334;1842.8709990300817;1865.5149661087944;785.2147852147853;874.7463235661714;875.7766769473743;974.3910056214866;993.1558175550724;15615.453459128876;15970.9201453992;17272.827271727372;17297;17643.823561764475;892.8392889279992;927.8329900617954;929.3866048408019;931.9440833550009;1014.1481155829139;8725.738227853175;8970.147835955573;9050.366474346733;9216.308776841764;9250.583723732449;362817;366878;367903;519664;521080;44557.55442445534;44945.325820112725;54563.45436545663;68597;73701;1009.9949500252599;1047.2198212331862;1124.9887501125047;1171.7246447084929;1173.3018853781816;14409;14758.48345307909;15036.924815376291;15262;15295.61760955985;25303.87348063248;31707.841460792548;31730.20674483064;33117.337653246315;34716.30567388688;39645.207095857346;39894;41102.38346424866;41107.177856443304;41846.790766045975;6733.494987875831;7294.379977701955;7303;7314.939333796676;7496.512726672749;10135.594576217163;10867.239293249713;11036.448177591248;11150.944245279046;11351.432428378383;3035.817850928863;3166.5725127107544;7180.3537681608905;9361.672341468016;9650.903490965282;9141.63433462654;9538.380005299634;9716.75708107303;9927.553260103168;9938.403695778277;9406.576704048472;9855.753606159904;9936.503174841084;9949.303548751517;10151.94924025375;7458.73894413693;7505.249475052451;7561.886571701319;7565.8108547284555;7581.279778421042;8942.46345219289;9512.667056652985;9732.41605503672;10155;10233.079022887976 07:19:58 INFO - PROCESS | 3733 | |3;mootools.html;1361.3669643615729;1405.676694360297;1435.5119259451785;1571.2929181868162;1794.4168145352764;6960.860782784342;7511.586862722548;7689.384849212063;7694.807629809257;7726.304632583066;7523.586202758846;7663;7720.459567830254;7727.61361931904;7735.613219339039;2036.1244664794133;2077.5013996640773;2251.549690061986;2260.1185537640295;2285.1430713482446;2263.8868056597184;2278.270953294946;2281.155972290255;2281.7147856517936;2282.6461898405773;2222.0667319725753;2295.8737269450176;2300.769923007703;2301.1255722825304;2302.7582103879104;2300.2869110575693;2322.082777302964;2325.0699720112007;2334.8015418689433;2338.7661233876474;2307.492351682644;2331.440454290975;2339.251439539348;2351.071326825894;2357.4931389751114;7780.183080776494;7813.726519571845;7825.217478252186;7827.530348179127;7828.412869034845;4751.0497900419705;4836.613070954315;4848.854534363974;4878.414590249157;4881.8779530511665;3229.9677003229904;3267.9019629411155;3314.022363402802;3363.83180840957;3367.5958884933966;1118.3848883114335;1127.7237076916126;1131.8472006279212;1133.2973556395004;1175.4592887271865;10645.148388128931;10700.839487407695;10749.623763168329;10761;10802.027817496462;4292.48490181174;4379.430674012358;4395.340698895191;4403.647708183337;4405.2511073117;9205.355625106313;9221.031791661779;9226.30802689801;9228.723138305862;9254.444733316022;4803.087413391444;4821.9035619288115;4844.539768721966;4847.515248475124;4847.80608775652;4436.689431739812;4450.599446049806;4456.153330867125;4458;4461.5092339842595;3463.8614455422003;3536.823158842099;3677.5219221501034;3683.1712864605784;3767.1147280389087;1190.345310079453;1226.3806777577267;1228.975420491585;1230.4647478346947;1237.7772001039718;1218.4273391505978;1220.8840160184768;1250.1811313589612;1276.1194775604804;1300.752856957175;7224.241454647186;7301.269873012656;7308.926910730931;7320.414366850639;7353.669084891193;1109.4619109731773;1112.8775834658181;1121.1759356872692;1121.7363919478917;1136.9374684392271;5876.647401155944;5957;5980.0431930890845;5981.222441082718;5982.850428739229;8733.912660873437;9056.547172641342;9071.183593476619;9163.129502697233;9337.159655631025;9030.548472576345;9066.909330906607;9077.137671921157;9078.636854525877;9087.36388452802;7243.855122897513;7322.1945585985495;7355.448341374418;7377.40980721541;7411.888821667571;7364.66858991336;7429.8142546436775;7437.925620743723;7441.255874412515;7462.10454745434;8362.707305244287;8426.915730842613;8624.137586241326;8648.610812513578;8815.955920220358;8637.481751094954;8826.823463530822;8980.820383592421;9006.50464224474;9019.819603608023;6788;6895.6207408591;6898.896516552356;6899.241083480913;6906.965465172642;6602.042703808017;6729.0579318894415;7147.499675022698;7326.487145899736;7330.193678695233;6871.793846184422;7033.050538177281;7057.082579264663;7095;7249.0213821135585;6866.34769696878;6873.415759660485;6973.6164510952385;6994.370506654425;7008.719651213894;6927.134108236471;6949.826254343682;6969.477289203229;6971.128608923885;6977.1278590176225;6350.809475715736;6447.323031081669;6488.70800813974;6509.218893732593;6530.934690653033;6574.901376479261;6605.405513503615;6622.07290979273;6628;6630 07:19:58 INFO - PROCESS | 3733 | |4;prototype.html;334.50493269960464;334.7706820827733;341.1471321695761;343.99140021499454;346.8491206325249;5758.683272420015;5858.824235272943;5859.355470898203;5880.705964701764;5904.793332233373;5633.15502674599;5778.075507918734;5788.507976821965;5810.215620891178;5820.970895145519;4478.216312145378;4526.954730452702;4537.795799189028;4538.704984176018;4544.363789069533;4342.174986752507;4436.622887054604;4458.331250312447;4463.843765468193;4535.954640453603;4425.048614547872;4432.268675668511;4474.686771925966;4475.440569928759;4505.481869584991;4496.437945256843;4508.098380323916;4511.639068874482;4512.368268442421;4512.5261847506035;3977.085270387798;3982.5021872265966;3982.884792258172;3983.601639836022;3993.5407428145845;5394.595405344615;5478.506934375885;5547.611667183299;5589.987604462391;5599.8880022399735;5202.4537423570355;5205.089109405839;5205.635605507616;5209.453007434241;5210.296609957683;5912.615679980788;6178.62928224308;6180.134781130645;6182.907256391158;6184;4190.392393103013;4206.516250631186;4298.613124818781;4299.634531064832;4341.544137865541;6367.044943258548;6367.6497792621385;6423.935760642427;6429.549931504796;6439.871202575969;4414.139242847614;4421.977890110529;4422.425084738963;4426.535213802569;4430.224710675619;4326.58897404746;4466.553344665573;4470.530594287618;4479.3057076153245;4479.731216127043;5123.385193776696;5142.305788718475;5154.252633368141;5174.482551744795;5178.6374953752875;6204.503639708812;6250.968745156245;6253.249610046823;6255.12428260044;6257.405546473078;1563.5700182449916;1574.330909363539;1584.4692028170462;1584.952451426459;1585.2232406120918;1049.8372752223418;1060.824963880951;1069.7432616172218;1070.1920050362082;1089.7493576477455;5861.648301101947;5862.267216597926;5875.089361149029;5875.941240587625;5880.588358814927;6353.555251132469;6413.518986076063;6419.2296924369375;6420.101185833987;6439.54923155384;5862.970685146547;5866.178734977107;5868.882622347529;5869.295684517885;5872.236609240771;3320.3027364253776;3434.708049815794;3437.813954185802;3439.673231043047;3441.587009558819;6625.701843417058;6635.137432133792;6639.269680335159;6640;6642.568233064835;6483.2544257411;6487.902681459782;6489.70796314167;6492.707828147744;6562;6503.837404064936;6642.269350371455;6685.53201275906;6697.3637504437975;6703.229128650268;6176.7838125665385;6323.7786677466065;6405.583637063576;6408.455281301141;6415.71129299192;6202.100695399052;6240.876642204446;6329.5252856036905;6348.301686814354;6353.36466353361;6617.205935287796;6669.7665581704405;6682.431993280626;6743.190817101783;6760.526763126534;4321.827126915014;4423.292273236267;4448.733076015449;4453.287474004143;4455.7994890229365;6359.936400636119;6368.267649220214;6376.713047912948;6377.202849643794;6379.138816259931;6195.628262304276;6204.348543402878;6204.5036397089025;6204.627722336674;6207.317195108625;6043.214382130295;6181.134641150153;6185.257769067741;6189.597676151036;6195.96902015487;6076.240469941257;6086.330503644507;6096.0855871619615;6098.664573448503;6108.57239993214;6250.06249062626;6265.154204182377;6267.905981410191;6272.655003974825;6275.058741188858;5919.644821310735;6114.969425152845;6121.693915304128;6130.601510901777;6133.877322453615 07:19:58 INFO - PROCESS | 3733 | |5;yui.html;753.834156485573;810.4245985350401;818.6152508321089;845.8054647431095;863.3697400897345;12513.624591262265;12520.311382873939;12624.368781560932;12634.557790477334;12662.176958497692;11802.409879506013;12021;12589.811152832715;12640.17838840477;12646.747065058693;806.4919100966398;819.1358117186365;821.2239433735123;822.4571782623469;823.2960818500186;803.4295650088415;803.6343463723991;803.9196080391944;806.9717559885405;813.2721214513007;852.4203541591716;852.8763329317245;853.1255463150259;853.3471894001094;858.6608289725555;848.1010129263001;849.0999540487103;849.1550906847664;851.2551517422255;863.3395452478859;626.7336382037615;628.246104674388;628.3936001758325;634.6636282770139;636.8089573128043;12252.142350035501;12271.079669024859;12322.753544929052;12329;12360.814587781191;11045.668629941114;11173.608923687712;11616.941915290454;12173.695657608541;12505.124641275115;10315.071643552117;10373.84439233412;10581.576736930514;10715.142788576895;11170.944145279222;3537.345591065661;3600.873969411084;3637.399829028207;3651.3062518121474;3654.177809992757;49079.50920490785;49229.26156107697;49814.252786208235;49905;50019.74990125062;9448.95275523618;9509;9583.424994500352;9584.76038099053;9830.741489753897;17494.737578936325;17518.38685645996;17577.648447030988;17586.12069396525;17634.294628214986;7687.308142267223;7796.8050798729355;7822.647980840876;7826;7924.564148971746;4238.470191226097;4240.406343111967;4277.957220427756;4364.4980827204645;4597.816087356535;3047.238190452387;3105.503119500869;3106.5650808886776;3108.1452600535035;3109.751219902402;558.2603050957498;559.4042344902666;560.8597850537366;577.5379696242989;579.8057650686983;611.5566214494456;650.7266947881901;670.8545456349809;676.8747781660409;690.3855568544;8269.173082691683;9808.509574521246;9810.362326448758;9998.15015723657;10002.44986525748;562.2609645855097;570.500811789684;695.2005194026909;712.6151877985933;720.6180724216174;4010.438538604598;4196.769177695256;4279.951411904103;4346.239408103569;4501.257292546758;50901;50917.236241456405;51800.48199518032;52080.73959630178;52243.477565224624;43992;47332.52667473281;48756.02487950221;49417;49694.75152624214;37159.4426083609;44360.334594981105;44533.77733111314;44978.77510612426;47858.21417858256;8616.90011389292;8841;8896.77758056028;8925.598348074222;9298.209652179641;31596.684033159374;31765.841170794;34142.65857341494;34851.825740871136;35160;43959.560404395546;44831.32753008773;46209.76895115637;46870.76564617155;47035.529644703114;11220.66338009861;11266;11366.261193022427;11406.543738250377;11550.59572914944;12260.816087758512;12473.313967731861;12682.619521414372;12704.237745735285;13118.540851070167;11736.413179341169;11966.714833823171;11978.161528692908;12238.326892020668;12400.441980111096;11759.235649682743;12123.575674851338;12192.51229950792;12295.815562766387;12569.057320700802;11335.773284534429;11822.763544729229;11846.881531184577;11863;12279.570215042431;9369.203617692572;9874.582479266675;10021.599136034769;10294.433806140734;10360.274780765274;8492.830143397221;9007.459552426875;9980.500974951368;10125.493725313852;10367.7793324005 07:19:58 INFO - PROCESS | 3733 | __end_tp_report 07:19:58 INFO - PROCESS | 3733 | __start_cc_report 07:19:58 INFO - PROCESS | 3733 | _x_x_mozilla_cycle_collect,987 07:19:58 INFO - PROCESS | 3733 | __end_cc_report 07:19:58 INFO - PROCESS | 3733 | __startTimestamp1453389598587__endTimestamp 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | ------- Summary: start ------- 07:19:58 INFO - PROCESS | 3733 | Number of tests: 6 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#0] dojo.html Cycles:165 Average:5161.63 Median:5386.65 stddev:552.91 (10.3%) stddev-sans-first:531.79 07:19:58 INFO - PROCESS | 3733 | Values: 3157.7 3168.0 3217.7 3225.1 3245.4 5047.9 5106.2 5200.1 5204.7 5255.5 5197.3 5198.5 5215.3 5219.5 5245.8 4697.7 4726.4 4730.6 4787.0 4826.8 4736.1 4749.3 4767.8 4803.4 4814.6 4645.6 4665.1 4715.5 4722.5 4738.5 4681.1 4686.2 4687.3 4694.0 4723.6 4673.6 4678.3 4679.1 4682.5 4722.9 4913.7 4945.1 4969.0 5020.1 5033.9 5461.5 5473.8 5474.8 5480.3 5489.5 5453.2 5495.6 5500.1 5518.5 5544.9 5147.2 5166.2 5175.8 5178.6 5202.5 5658.2 5659.8 5659.8 5665.5 5679.5 5390.2 5432.7 5448.3 5453.3 5453.7 5466.9 5498.5 5610.3 5625.4 5648.0 5513.7 5517.7 5522.1 5523.1 5530.9 5462.5 5500.8 5507.9 5517.8 5557.9 4289.8 4311.9 4328.0 4344.7 4357.5 3866.3 3881.9 3895.8 3922.7 3936.6 5199.8 5206.3 5213.0 5216.6 5248.4 5513.3 5556.4 5590.9 5601.2 5626.5 5192.2 5226.6 5228.1 5229.7 5232.3 4703.8 4781.8 4784.1 4784.3 4833.9 5743.7 5771.2 5785.4 5819.3 5863.4 5572.7 5578.0 5580.7 5581.4 5587.6 5749.9 5795.4 5803.4 5806.4 5806.7 5425.9 5464.3 5468.7 5469.0 5515.3 5521.5 5560.5 5576.9 5577.5 5582.9 5336.4 5346.4 5422.3 5435.8 5453.8 5462.5 5464.1 5471.8 5473.4 5492.8 5352.3 5366.9 5372.9 5381.8 5436.3 5369.0 5386.6 5419.3 5431.8 5472.2 5415.1 5417.5 5421.9 5427.7 5437.3 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#1] ext.html Cycles:180 Average:46325.84 Median:20195.37 stddev:78943.27 (390.9%) stddev-sans-first:79089.80 07:19:58 INFO - PROCESS | 3733 | Values: 516.1 551.2 573.3 613.4 616.7 36551.0 37088.6 37128.6 37152.4 37190.8 40475.2 41053.0 41056.6 41107.4 41120.2 8326.7 8501.7 8516.7 8528.8 8534.3 8205.9 8265.9 8325.2 8509.6 8517.0 8524.9 8597.2 8607.6 8609.3 8617.4 8478.1 8548.5 8552.8 8559.0 8591.8 8364.6 8480.8 8488.1 8490.9 8492.2 39941.0 40414.6 40427.8 40428.0 40429.8 3274.6 3491.0 3665.7 3925.3 3955.5 30050.2 30302.4 30679.2 30717.6 30729.0 3899.7 3904.4 3955.5 4004.6 4009.4 252037.7 252739.4 252891.0 253387.7 254012.0 58054.7 58316.0 58380.7 58393.7 58433.4 62439.0 62677.4 62834.7 62896.7 62934.0 15241.5 15395.1 15415.2 15429.5 15439.2 11401.8 11509.8 11526.1 11542.6 11569.3 18735.8 19715.9 19751.5 19865.5 19919.3 6021.8 7426.5 7519.6 7582.2 8032.2 895.8 1010.6 1010.7 1015.8 1049.2 26613.9 29325.4 29608.7 30456.2 30504.2 1010.2 1011.9 1046.6 1075.8 1148.3 13771.8 13800.0 14058.1 14431.3 14516.3 300431.0 301891.0 428227.0 428427.0 435945.0 52165.7 52848.2 52967.2 53053.2 53167.5 1275.8 1285.1 1287.7 1288.6 1292.0 25055.6 25628.9 29082.6 29371.3 29842.1 48027.0 48184.8 48249.8 48269.0 48301.0 241995.0 242841.0 243173.0 243515.0 243566.0 31033.8 31343.7 31697.4 31720.5 32099.7 40443.2 40606.8 41103.4 41114.0 41213.0 34911.5 35259.6 36367.3 36833.0 37320.8 35777.3 35894.5 36077.8 36725.0 36907.4 34728.7 35721.5 35729.6 35743.0 35777.5 29663.9 32542.8 32874.2 32972.8 33091.2 24945.3 25977.2 32899.7 33389.5 33427.2 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#2] jquery.html Cycles:180 Average:23725.77 Median:4520.24 stddev:70975.92 (1570.2%) stddev-sans-first:71153.34 07:19:58 INFO - PROCESS | 3733 | Values: 364.6 367.6 369.3 370.1 370.8 13461.3 13549.9 15478.1 16854.5 17872.1 15346.6 15786.6 15811.1 15915.4 16998.2 4928.6 5461.7 5465.7 5468.0 5470.3 4022.4 4121.9 5348.5 5454.8 5707.4 5658.8 5785.2 5867.2 5868.9 5871.5 5941.0 5990.1 6010.5 6015.9 6016.1 4962.2 5178.6 5179.6 5299.6 5299.9 18273.0 18520.6 18730.5 18925.8 18973.3 2012.7 2042.2 2095.2 2185.8 2219.6 9000.8 9261.5 9286.8 9424.7 9729.2 1699.6 1700.1 1700.5 1716.6 1723.8 56232.4 56697.7 56859.0 57481.4 57864.7 9931.0 10070.1 10111.3 10139.7 10186.2 13171.9 13271.1 13330.1 13333.2 13371.2 7358.8 7388.4 7398.6 7439.0 7463.0 7026.2 7028.1 7074.4 7095.0 7095.2 4408.6 4479.2 4486.1 4519.0 4521.5 1717.7 1775.7 1801.5 1842.9 1865.5 785.2 874.7 875.8 974.4 993.2 15615.5 15970.9 17272.8 17297.0 17643.8 892.8 927.8 929.4 931.9 1014.1 8725.7 8970.1 9050.4 9216.3 9250.6 362817.0 366878.0 367903.0 519664.0 521080.0 44557.6 44945.3 54563.5 68597.0 73701.0 1010.0 1047.2 1125.0 1171.7 1173.3 14409.0 14758.5 15036.9 15262.0 15295.6 25303.9 31707.8 31730.2 33117.3 34716.3 39645.2 39894.0 41102.4 41107.2 41846.8 6733.5 7294.4 7303.0 7314.9 7496.5 10135.6 10867.2 11036.4 11150.9 11351.4 3035.8 3166.6 7180.4 9361.7 9650.9 9141.6 9538.4 9716.8 9927.6 9938.4 9406.6 9855.8 9936.5 9949.3 10151.9 7458.7 7505.2 7561.9 7565.8 7581.3 8942.5 9512.7 9732.4 10155.0 10233.1 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#3] mootools.html Cycles:180 Average:5489.86 Median:6399.07 stddev:2795.00 (43.7%) stddev-sans-first:2785.61 07:19:58 INFO - PROCESS | 3733 | Values: 1361.4 1405.7 1435.5 1571.3 1794.4 6960.9 7511.6 7689.4 7694.8 7726.3 7523.6 7663.0 7720.5 7727.6 7735.6 2036.1 2077.5 2251.5 2260.1 2285.1 2263.9 2278.3 2281.2 2281.7 2282.6 2222.1 2295.9 2300.8 2301.1 2302.8 2300.3 2322.1 2325.1 2334.8 2338.8 2307.5 2331.4 2339.3 2351.1 2357.5 7780.2 7813.7 7825.2 7827.5 7828.4 4751.0 4836.6 4848.9 4878.4 4881.9 3230.0 3267.9 3314.0 3363.8 3367.6 1118.4 1127.7 1131.8 1133.3 1175.5 10645.1 10700.8 10749.6 10761.0 10802.0 4292.5 4379.4 4395.3 4403.6 4405.3 9205.4 9221.0 9226.3 9228.7 9254.4 4803.1 4821.9 4844.5 4847.5 4847.8 4436.7 4450.6 4456.2 4458.0 4461.5 3463.9 3536.8 3677.5 3683.2 3767.1 1190.3 1226.4 1229.0 1230.5 1237.8 1218.4 1220.9 1250.2 1276.1 1300.8 7224.2 7301.3 7308.9 7320.4 7353.7 1109.5 1112.9 1121.2 1121.7 1136.9 5876.6 5957.0 5980.0 5981.2 5982.9 8733.9 9056.5 9071.2 9163.1 9337.2 9030.5 9066.9 9077.1 9078.6 9087.4 7243.9 7322.2 7355.4 7377.4 7411.9 7364.7 7429.8 7437.9 7441.3 7462.1 8362.7 8426.9 8624.1 8648.6 8816.0 8637.5 8826.8 8980.8 9006.5 9019.8 6788.0 6895.6 6898.9 6899.2 6907.0 6602.0 6729.1 7147.5 7326.5 7330.2 6871.8 7033.1 7057.1 7095.0 7249.0 6866.3 6873.4 6973.6 6994.4 7008.7 6927.1 6949.8 6969.5 6971.1 6977.1 6350.8 6447.3 6488.7 6509.2 6530.9 6574.9 6605.4 6622.1 6628.0 6630.0 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#4] prototype.html Cycles:180 Average:5183.66 Median:5864.57 stddev:1554.10 (26.5%) stddev-sans-first:1515.25 07:19:58 INFO - PROCESS | 3733 | Values: 334.5 334.8 341.1 344.0 346.8 5758.7 5858.8 5859.4 5880.7 5904.8 5633.2 5778.1 5788.5 5810.2 5821.0 4478.2 4527.0 4537.8 4538.7 4544.4 4342.2 4436.6 4458.3 4463.8 4536.0 4425.0 4432.3 4474.7 4475.4 4505.5 4496.4 4508.1 4511.6 4512.4 4512.5 3977.1 3982.5 3982.9 3983.6 3993.5 5394.6 5478.5 5547.6 5590.0 5599.9 5202.5 5205.1 5205.6 5209.5 5210.3 5912.6 6178.6 6180.1 6182.9 6184.0 4190.4 4206.5 4298.6 4299.6 4341.5 6367.0 6367.6 6423.9 6429.5 6439.9 4414.1 4422.0 4422.4 4426.5 4430.2 4326.6 4466.6 4470.5 4479.3 4479.7 5123.4 5142.3 5154.3 5174.5 5178.6 6204.5 6251.0 6253.2 6255.1 6257.4 1563.6 1574.3 1584.5 1585.0 1585.2 1049.8 1060.8 1069.7 1070.2 1089.7 5861.6 5862.3 5875.1 5875.9 5880.6 6353.6 6413.5 6419.2 6420.1 6439.5 5863.0 5866.2 5868.9 5869.3 5872.2 3320.3 3434.7 3437.8 3439.7 3441.6 6625.7 6635.1 6639.3 6640.0 6642.6 6483.3 6487.9 6489.7 6492.7 6562.0 6503.8 6642.3 6685.5 6697.4 6703.2 6176.8 6323.8 6405.6 6408.5 6415.7 6202.1 6240.9 6329.5 6348.3 6353.4 6617.2 6669.8 6682.4 6743.2 6760.5 4321.8 4423.3 4448.7 4453.3 4455.8 6359.9 6368.3 6376.7 6377.2 6379.1 6195.6 6204.3 6204.5 6204.6 6207.3 6043.2 6181.1 6185.3 6189.6 6196.0 6076.2 6086.3 6096.1 6098.7 6108.6 6250.1 6265.2 6267.9 6272.7 6275.1 5919.6 6115.0 6121.7 6130.6 6133.9 07:19:58 INFO - PROCESS | 3733 | 07:19:58 INFO - PROCESS | 3733 | [#5] yui.html Cycles:180 Average:13521.76 Median:24740.02 stddev:15236.97 (61.6%) stddev-sans-first:15249.55 07:19:58 INFO - PROCESS | 3733 | Values: 753.8 810.4 818.6 845.8 863.4 12513.6 12520.3 12624.4 12634.6 12662.2 11802.4 12021.0 12589.8 12640.2 12646.7 806.5 819.1 821.2 822.5 823.3 803.4 803.6 803.9 807.0 813.3 852.4 852.9 853.1 853.3 858.7 848.1 849.1 849.2 851.3 863.3 626.7 628.2 628.4 634.7 636.8 12252.1 12271.1 12322.8 12329.0 12360.8 11045.7 11173.6 11616.9 12173.7 12505.1 10315.1 10373.8 10581.6 10715.1 11170.9 3537.3 3600.9 3637.4 3651.3 3654.2 49079.5 49229.3 49814.3 49905.0 50019.7 9449.0 9509.0 9583.4 9584.8 9830.7 17494.7 17518.4 17577.6 17586.1 17634.3 7687.3 7796.8 7822.6 7826.0 7924.6 4238.5 4240.4 4278.0 4364.5 4597.8 3047.2 3105.5 3106.6 3108.1 3109.8 558.3 559.4 560.9 577.5 579.8 611.6 650.7 670.9 676.9 690.4 8269.2 9808.5 9810.4 9998.2 10002.4 562.3 570.5 695.2 712.6 720.6 4010.4 4196.8 4280.0 4346.2 4501.3 50901.0 50917.2 51800.5 52080.7 52243.5 43992.0 47332.5 48756.0 49417.0 49694.8 37159.4 44360.3 44533.8 44978.8 47858.2 8616.9 8841.0 8896.8 8925.6 9298.2 31596.7 31765.8 34142.7 34851.8 35160.0 43959.6 44831.3 46209.8 46870.8 47035.5 11220.7 11266.0 11366.3 11406.5 11550.6 12260.8 12473.3 12682.6 12704.2 13118.5 11736.4 11966.7 11978.2 12238.3 12400.4 11759.2 12123.6 12192.5 12295.8 12569.1 11335.8 11822.8 11846.9 11863.0 12279.6 9369.2 9874.6 10021.6 10294.4 10360.3 8492.8 9007.5 9980.5 10125.5 10367.8 07:19:58 INFO - PROCESS | 3733 | -------- Summary: end -------- 07:19:58 INFO - PROCESS | 3733 | 07:19:59 INFO - TEST-INFO | 3733: exit 0 07:19:59 INFO - TEST-OK | dromaeo_css | took 1112481ms 07:19:59 INFO - TEST-START | kraken 07:19:59 INFO - operating with platform_type : linux_ 07:19:59 INFO - Initialising browser for kraken test... 07:19:59 INFO - TEST-INFO | started process 3936 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRJbaAB/profile http://localhost:37509/getInfo.html) 07:20:02 INFO - PROCESS | 3936 | __metrics Screen width/height:1600/1200 07:20:02 INFO - PROCESS | 3936 | colorDepth:24 07:20:02 INFO - PROCESS | 3936 | Browser inner width/height: 1024/697 07:20:02 INFO - PROCESS | 3936 | __metrics 07:20:02 INFO - PROCESS | 3936 | 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:20:03 INFO - PROCESS | 3936 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:20:04 INFO - TEST-INFO | 3936: exit 0 07:20:04 INFO - Browser initialized. 07:20:04 INFO - Running cycle 1/1 for kraken test... 07:20:04 INFO - TEST-INFO | started process 4021 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRJbaAB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:15 INFO - PROCESS | 4021 | RSS: Main: 149041152 07:20:15 INFO - PROCESS | 4021 | 07:20:18 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37509/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:18 INFO - PROCESS | 4021 | RSS: Main: 185466880 07:20:18 INFO - PROCESS | 4021 | 07:20:21 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37509/tests/kraken/driver.html?testName=audio-dft) 07:20:22 INFO - PROCESS | 4021 | RSS: Main: 176824320 07:20:22 INFO - PROCESS | 4021 | 07:20:24 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37509/tests/kraken/driver.html?testName=audio-fft) 07:20:25 INFO - PROCESS | 4021 | RSS: Main: 164397056 07:20:25 INFO - PROCESS | 4021 | 07:20:27 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37509/tests/kraken/driver.html?testName=audio-oscillator) 07:20:28 INFO - PROCESS | 4021 | RSS: Main: 164630528 07:20:28 INFO - PROCESS | 4021 | 07:20:30 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:30 INFO - PROCESS | 4021 | RSS: Main: 165244928 07:20:30 INFO - PROCESS | 4021 | 07:20:33 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37509/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:34 INFO - PROCESS | 4021 | RSS: Main: 164769792 07:20:34 INFO - PROCESS | 4021 | 07:20:37 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37509/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:38 INFO - PROCESS | 4021 | RSS: Main: 167047168 07:20:38 INFO - PROCESS | 4021 | 07:20:41 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37509/tests/kraken/driver.html?testName=json-parse-financial) 07:20:41 INFO - PROCESS | 4021 | RSS: Main: 166539264 07:20:41 INFO - PROCESS | 4021 | 07:20:43 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:43 INFO - PROCESS | 4021 | RSS: Main: 179290112 07:20:43 INFO - PROCESS | 4021 | 07:20:45 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:46 INFO - PROCESS | 4021 | RSS: Main: 176103424 07:20:46 INFO - PROCESS | 4021 | 07:20:48 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:48 INFO - PROCESS | 4021 | RSS: Main: 180609024 07:20:48 INFO - PROCESS | 4021 | 07:20:51 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:51 INFO - PROCESS | 4021 | RSS: Main: 188465152 07:20:51 INFO - PROCESS | 4021 | 07:20:54 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:54 INFO - PROCESS | 4021 | RSS: Main: 186748928 07:20:54 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | Cycle 1(1): loaded http://localhost:37509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37509/tests/kraken/driver.html?testName=ai-astar) 07:20:56 INFO - PROCESS | 4021 | RSS: Main: 245235712 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | __start_tp_report 07:20:56 INFO - PROCESS | 4021 | _x_x_mozilla_page_load 07:20:56 INFO - PROCESS | 4021 | _x_x_mozilla_page_load_details 07:20:56 INFO - PROCESS | 4021 | |i|pagename|runs| 07:20:56 INFO - PROCESS | 4021 | |0;ai-astar;111;109;105;110;110;109;109;110;102;110 07:20:56 INFO - PROCESS | 4021 | |1;audio-beat-detection;158;126;152;162;126;152;149;126;169;134 07:20:56 INFO - PROCESS | 4021 | |2;audio-dft;160;159;159;160;158;164;158;159;160;161 07:20:56 INFO - PROCESS | 4021 | |3;audio-fft;73;72;73;151;71;72;73;73;152;73 07:20:56 INFO - PROCESS | 4021 | |4;audio-oscillator;96;97;153;96;100;95;143;96;97;145 07:20:56 INFO - PROCESS | 4021 | |5;imaging-gaussian-blur;110;110;110;109;109;109;109;109;109;109 07:20:56 INFO - PROCESS | 4021 | |6;imaging-darkroom;146;146;146;147;147;146;146;145;146;146 07:20:56 INFO - PROCESS | 4021 | |7;imaging-desaturate;96;95;96;95;95;96;95;95;96;96 07:20:56 INFO - PROCESS | 4021 | |8;json-parse-financial;57;57;56;56;57;57;55;56;57;55 07:20:56 INFO - PROCESS | 4021 | |9;json-stringify-tinderbox;68;69;68;68;70;69;69;68;68;68 07:20:56 INFO - PROCESS | 4021 | |10;stanford-crypto-aes;83;82;88;82;82;84;82;83;82;86 07:20:56 INFO - PROCESS | 4021 | |11;stanford-crypto-ccm;124;115;125;117;116;115;113;120;114;119 07:20:56 INFO - PROCESS | 4021 | |12;stanford-crypto-pbkdf2;153;141;141;144;146;132;137;141;146;141 07:20:56 INFO - PROCESS | 4021 | |13;stanford-crypto-sha256-iterative;69;69;67;67;66;68;68;65;69;67 07:20:56 INFO - PROCESS | 4021 | __end_tp_report 07:20:56 INFO - PROCESS | 4021 | __start_cc_report 07:20:56 INFO - PROCESS | 4021 | _x_x_mozilla_cycle_collect,935 07:20:56 INFO - PROCESS | 4021 | __end_cc_report 07:20:56 INFO - PROCESS | 4021 | __startTimestamp1453389656866__endTimestamp 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | ------- Summary: start ------- 07:20:56 INFO - PROCESS | 4021 | Number of tests: 14 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:2.80 (2.5%) stddev-sans-first:2.82 07:20:56 INFO - PROCESS | 4021 | Values: 111.0 109.0 105.0 110.0 110.0 109.0 109.0 110.0 102.0 110.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:152.00 stddev:16.16 (10.6%) stddev-sans-first:16.48 07:20:56 INFO - PROCESS | 4021 | Values: 158.0 126.0 152.0 162.0 126.0 152.0 149.0 126.0 169.0 134.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:1.75 (1.1%) stddev-sans-first:1.86 07:20:56 INFO - PROCESS | 4021 | Values: 160.0 159.0 159.0 160.0 158.0 164.0 158.0 159.0 160.0 161.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#3] audio-fft Cycles:10 Average:88.30 Median:73.00 stddev:33.32 (45.6%) stddev-sans-first:34.87 07:20:56 INFO - PROCESS | 4021 | Values: 73.0 72.0 73.0 151.0 71.0 72.0 73.0 73.0 152.0 73.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:96.00 stddev:24.45 (25.5%) stddev-sans-first:25.26 07:20:56 INFO - PROCESS | 4021 | Values: 96.0 97.0 153.0 96.0 100.0 95.0 143.0 96.0 97.0 145.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:20:56 INFO - PROCESS | 4021 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:20:56 INFO - PROCESS | 4021 | Values: 146.0 146.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:20:56 INFO - PROCESS | 4021 | Values: 96.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 07:20:56 INFO - PROCESS | 4021 | Values: 57.0 57.0 56.0 56.0 57.0 57.0 55.0 56.0 57.0 55.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 07:20:56 INFO - PROCESS | 4021 | Values: 68.0 69.0 68.0 68.0 70.0 69.0 69.0 68.0 68.0 68.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:2.19 07:20:56 INFO - PROCESS | 4021 | Values: 83.0 82.0 88.0 82.0 82.0 84.0 82.0 83.0 82.0 86.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:118.00 stddev:4.13 (3.5%) stddev-sans-first:3.72 07:20:56 INFO - PROCESS | 4021 | Values: 124.0 115.0 125.0 117.0 116.0 115.0 113.0 120.0 114.0 119.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:142.50 stddev:5.63 (4.0%) stddev-sans-first:4.42 07:20:56 INFO - PROCESS | 4021 | Values: 153.0 141.0 141.0 144.0 146.0 132.0 137.0 141.0 146.0 141.0 07:20:56 INFO - PROCESS | 4021 | 07:20:56 INFO - PROCESS | 4021 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.32 07:20:56 INFO - PROCESS | 4021 | Values: 69.0 69.0 67.0 67.0 66.0 68.0 68.0 65.0 69.0 67.0 07:20:56 INFO - PROCESS | 4021 | -------- Summary: end -------- 07:20:56 INFO - PROCESS | 4021 | 07:20:57 INFO - TEST-INFO | 4021: exit 0 07:20:57 INFO - TEST-OK | kraken | took 58520ms 07:20:57 INFO - TEST-START | v8_7 07:20:57 INFO - operating with platform_type : linux_ 07:20:57 INFO - Initialising browser for v8_7 test... 07:20:57 INFO - TEST-INFO | started process 4272 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE3WPLU/profile http://localhost:37509/getInfo.html) 07:21:01 INFO - PROCESS | 4272 | __metrics Screen width/height:1600/1200 07:21:01 INFO - PROCESS | 4272 | colorDepth:24 07:21:01 INFO - PROCESS | 4272 | Browser inner width/height: 1024/697 07:21:01 INFO - PROCESS | 4272 | __metrics 07:21:01 INFO - PROCESS | 4272 | 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:21:01 INFO - PROCESS | 4272 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:21:02 INFO - TEST-INFO | 4272: exit 0 07:21:02 INFO - Browser initialized. 07:21:02 INFO - Running cycle 1/1 for v8_7 test... 07:21:02 INFO - TEST-INFO | started process 4353 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpE3WPLU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:14 INFO - PROCESS | 4353 | RSS: Main: 149164032 07:21:14 INFO - PROCESS | 4353 | 07:21:36 INFO - PROCESS | 4353 | Cycle 1(1): loaded http://localhost:37509/tests/v8_7/run.html (next: http://localhost:37509/tests/v8_7/run.html) 07:21:37 INFO - PROCESS | 4353 | RSS: Main: 554418176 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | __start_tp_report 07:21:37 INFO - PROCESS | 4353 | _x_x_mozilla_page_load 07:21:37 INFO - PROCESS | 4353 | _x_x_mozilla_page_load_details 07:21:37 INFO - PROCESS | 4353 | |i|pagename|runs| 07:21:37 INFO - PROCESS | 4353 | |0;Richards;167.84155756965424 07:21:37 INFO - PROCESS | 4353 | |1;DeltaBlue;188.5014137606032 07:21:37 INFO - PROCESS | 4353 | |2;Encrypt;279.2516056967328 07:21:37 INFO - PROCESS | 4353 | |3;Decrypt;5256.544502617801 07:21:37 INFO - PROCESS | 4353 | |4;RayTrace;1958.9041095890411 07:21:37 INFO - PROCESS | 4353 | |5;Earley;791.7656373713381 07:21:37 INFO - PROCESS | 4353 | |6;Boyer;12493.827160493827 07:21:37 INFO - PROCESS | 4353 | |7;RegExp;42604.166666666664 07:21:37 INFO - PROCESS | 4353 | |8;Splay;573.0659025787966 07:21:37 INFO - PROCESS | 4353 | |9;NavierStokes;4822.115384615385 07:21:37 INFO - PROCESS | 4353 | __end_tp_report 07:21:37 INFO - PROCESS | 4353 | __startTimestamp1453389697244__endTimestamp 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | ------- Summary: start ------- 07:21:37 INFO - PROCESS | 4353 | Number of tests: 10 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 167.8 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#1] DeltaBlue Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 188.5 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 279.3 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 5256.5 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#4] RayTrace Cycles:1 Average:1958.90 Median:1958.90 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 1958.9 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 791.8 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#6] Boyer Cycles:1 Average:12493.83 Median:12493.83 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 12493.8 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#7] RegExp Cycles:1 Average:42604.17 Median:42604.17 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 42604.2 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#8] Splay Cycles:1 Average:573.07 Median:573.07 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 573.1 07:21:37 INFO - PROCESS | 4353 | 07:21:37 INFO - PROCESS | 4353 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:21:37 INFO - PROCESS | 4353 | Values: 4822.1 07:21:37 INFO - PROCESS | 4353 | -------- Summary: end -------- 07:21:37 INFO - PROCESS | 4353 | 07:21:38 INFO - TEST-INFO | 4353: exit 0 07:21:38 INFO - TEST-OK | v8_7 | took 40351ms 07:21:38 INFO - SUITE-END | took 1211s 07:21:38 INFO - Completed test suite (00:20:11) 07:21:38 INFO - Working with test: dromaeo_css 07:21:38 INFO - Generating results file: dromaeo_css 07:21:38 INFO - Working with test: kraken 07:21:38 INFO - Generating results file: kraken 07:21:38 INFO - javascript benchmark 07:21:38 INFO - Working with test: v8_7 07:21:38 INFO - Generating results file: v8_7 07:21:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:21:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:21:38 INFO - process_Request line: dromaeo_css 6816.57 graph.html#tests=[[72,1,35]] 07:21:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:21:38 INFO - process_Request line: kraken 1500.40 graph.html#tests=[[232,1,35]] 07:21:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:21:38 INFO - process_Request line: v8_7 18947.91 graph.html#tests=[[230,1,35]] 07:21:38 INFO - RETURN: dromaeo_css: 6816.57 07:21:38 INFO - RETURN: kraken: 1500.40 07:21:38 INFO - RETURN: v8_7: 18947.91 07:21:38 INFO - javascript benchmark 07:21:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3157.731592814611, 3168.0, 3217.662145474725, 3225.1453364858303, 3245.3671534050854, 5047.924281135786, 5106.183010718277, 5200.115980283352, 5204.671393672171, 5255.527002569768, 5197.272381866542, 5198.532132108109, 5215.295935048767, 5219.45195754446, 5245.79016839327, 4697.694649847766, 4726.385569875912, 4730.597899178574, 4787.0, 4826.7827947742435, 4736.100140973222, 4749.287606858981, 4767.785449654774, 4803.3515475410895, 4814.566688997989, 4645.605123564467, 4665.0669866026765, 4715.457722361938, 4722.456917454502, 4738.478767335608, 4681.133990211822, 4686.156491831469, 4687.2969054641735, 4693.9765301173275, 4723.598494128003, 4673.556012178838, 4678.251479763256, 4679.110968915895, 4682.484926658065, 4722.858314250578, 4913.656044076916, 4945.109880221558, 4969.031038947407, 5020.146575082208, 5033.899322013539, 5461.481159289861, 5473.75368108436, 5474.808381706661, 5480.314960629921, 5489.505944464978, 5453.209284653703, 5495.6153069285165, 5500.119980803092, 5518.475744804237, 5544.91682624761, 5147.22791581262, 5166.225066240057, 5175.818846340398, 5178.637495375363, 5202.453742357074, 5658.151277308437, 5659.801906933238, 5659.801906933238, 5665.5184309333345, 5679.545636349082, 5390.19147127934, 5432.728363581805, 5448.291722076105, 5453.263809385761, 5453.672779633234, 5466.9179962300595, 5498.45015498447, 5610.270664813548, 5625.353084395265, 5647.971760141173, 5513.669179849222, 5517.668939863541, 5522.061249587579, 5523.061079616475, 5530.944690553043, 5462.481064298885, 5500.779968801203, 5507.944920550824, 5517.806876759294, 5557.944420555824, 4289.849855255051, 4311.935320970188, 4327.978360108179, 4344.739315641072, 4357.542458041923, 3866.2654095721723, 3881.8835434936996, 3895.824687888995, 3922.7450215735885, 3936.586658400884, 5199.818006369759, 5206.271122042917, 5213.0, 5216.556592689588, 5248.448912864094, 5513.255710479034, 5556.388797232301, 5590.91613625796, 5601.215829783833, 5626.521745651666, 5192.169252919514, 5226.608004399685, 5228.137357335997, 5229.6600720953775, 5232.319798426181, 4703.811847526129, 4781.784819683123, 4784.138855006063, 4784.282357646381, 4833.854984350475, 5743.712814359265, 5771.192033115367, 5785.363610002896, 5819.301683797971, 5863.355030946593, 5572.665640061609, 5578.023845827045, 5580.693061881636, 5581.441855814386, 5587.636803607753, 5749.91375129365, 5795.420457954171, 5803.448672376117, 5806.361300256884, 5806.738696758741, 5425.891482170256, 5464.262324586289, 5468.726563671721, 5468.972655136698, 5515.255440515479, 5521.5306698929435, 5560.527355174855, 5576.86057848557, 5577.498025177753, 5582.888342233214, 5336.359636843604, 5346.385165705994, 5422.295101636762, 5435.83692489226, 5453.7818487260065, 5462.508374246337, 5464.1257398816, 5471.8084867029465, 5473.397926228191, 5492.80775172867, 5352.250684904038, 5366.865828354323, 5372.892542149057, 5381.784728610812, 5436.320459942507, 5368.979893820162, 5386.649867758583, 5419.34967803866, 5431.8098866539485, 5472.151816468454, 5415.1335786274, 5417.512423881712, 5421.9186712200135, 5427.728613569227, 5437.293151890387], "unit": "score", "name": "dojo.html", "value": 5127.437517594124}, {"lowerIsBetter": false, "replicates": [516.1148630099381, 551.1759918921214, 573.3233709851493, 613.3774219167544, 616.747133675193, 36551.0, 37088.629113708856, 37128.62871371285, 37152.44271335932, 37190.814045929765, 40475.19049619006, 41053.0, 41056.58943410565, 41107.38338924918, 41120.177596448055, 8326.666933322675, 8501.744947651581, 8516.74449766505, 8528.78678033048, 8534.317254619615, 8205.917940820606, 8265.876011859827, 8325.209105135002, 8509.61706723199, 8516.957415212915, 8524.8721269181, 8597.18326758957, 8607.569621518931, 8609.26821220197, 8617.353698472609, 8478.109798471165, 8548.529830859301, 8552.828943421127, 8558.957205213965, 8591.785205369915, 8364.58177091143, 8480.830383392298, 8488.066312705598, 8490.872636910452, 8492.193241642035, 39941.0, 40414.59585404138, 40427.797861010804, 40428.0, 40429.79785101085, 3274.590676165479, 3491.0050635568996, 3665.7433979621437, 3925.2738243425056, 3955.4857868476915, 30050.24874378136, 30302.393952121056, 30679.2330191747, 30717.62106168342, 30729.0, 3899.6685281751083, 3904.39481880309, 3955.46601208836, 4004.619561141687, 4009.4386785850006, 252037.6583053767, 252739.41781746576, 252891.0, 253387.73306133537, 254012.0, 58054.70972645194, 58316.0, 58380.7080964601, 58393.70803146042, 58433.41566584365, 62439.0, 62677.35903768683, 62834.68582657149, 62896.68551657212, 62934.0, 15241.466548670744, 15395.07629542231, 15415.229238538253, 15429.459968901034, 15439.150846703315, 11401.828972565418, 11509.827352589718, 11526.135539834546, 11542.59600913964, 11569.305841649528, 18735.757211834152, 19715.901420492806, 19751.506212344808, 19865.503362416057, 19919.302824401075, 6021.849453763691, 7426.517276377126, 7519.624018799038, 7582.165961744204, 8032.236937490929, 895.8253140637644, 1010.5604062232952, 1010.696790962723, 1015.817152912468, 1049.2031525819755, 26613.866930665223, 29325.413491730047, 29608.703912960595, 30456.238594034883, 30504.237394064883, 1010.2120346130031, 1011.9291649584605, 1046.6284469013542, 1075.8440026196315, 1148.2823235477827, 13771.793423098661, 13800.0, 14058.086224395382, 14431.340395854611, 14516.274186290855, 300431.0, 301891.0, 428227.0, 428427.0, 435945.0, 52165.73917130466, 52848.20727689088, 52967.20549191765, 53053.204201937, 53167.46832531702, 1275.8277632519678, 1285.1261142423054, 1287.6909541710108, 1288.6134159752037, 1291.9935400322938, 25055.624165637895, 25628.871855641348, 29082.56376154317, 29371.265718357212, 29842.104736857927, 48027.0, 48184.75907620439, 48249.758751207424, 48269.0, 48301.0, 241995.0, 242841.0, 243173.0, 243515.0, 243566.0, 31033.844830775703, 31343.68656313499, 31697.366052678357, 31720.524192137596, 32099.67900320967, 40443.1911361777, 40606.79696601498, 41103.38344924888, 41114.0, 41213.0, 34911.476327854594, 35259.64740352564, 36367.27265454729, 36833.0, 37320.81339593285, 35777.28445431129, 35894.461583075754, 36077.81961090178, 36725.0, 36907.44638830366, 34728.65271347254, 35721.46417803683, 35729.64270357367, 35743.0, 35777.46333805047, 29663.85168074146, 32542.83728581342, 32874.17814554655, 32972.83513582417, 33091.172720682174, 24945.251642450756, 25977.220683379528, 32899.67100328966, 33389.49915751217, 33427.164320892174], "unit": "score", "name": "ext.html", "value": 18405.309108425037}, {"lowerIsBetter": false, "replicates": [364.5825529768414, 367.5662717992768, 369.2817470020809, 370.06189310098904, 370.8294184675049, 13461.326933653327, 13549.864501354983, 15478.148701821396, 16854.49436516905, 17872.106394680246, 15346.616334591612, 15786.605334866634, 15811.130387828665, 15915.44295949642, 16998.235079421425, 4928.605711543077, 5461.672299662033, 5465.699386533739, 5468.0, 5470.343558772953, 4022.376531637586, 4121.896952576195, 5348.46515348464, 5454.7818087276655, 5707.429257074301, 5658.773649054054, 5785.247917770684, 5867.207926929874, 5868.882622347551, 5871.530277577784, 5940.97029514854, 5990.131430942489, 6010.489108425789, 6015.909761353583, 6016.067509536029, 4962.206047032458, 5178.585713142939, 5179.611529135293, 5299.6025298102795, 5299.867503312409, 18273.0, 18520.629587408177, 18730.531736706693, 18925.810741892543, 18973.335933242408, 2012.6578481658007, 2042.2137477071285, 2095.1828786773017, 2185.7595664476894, 2219.6448568229166, 9000.819983600357, 9261.536923153815, 9286.767830804216, 9424.670136545188, 9729.173020293283, 1699.600593860442, 1700.1074435921116, 1700.523853321072, 1716.6223430845193, 1723.8017627972818, 56232.43767562313, 56697.716511417595, 56859.0, 57481.42518574803, 57864.71067644677, 9930.950345248228, 10070.144037756727, 10111.292209545261, 10139.7465063374, 10186.185105191567, 13171.934140329236, 13271.137376070525, 13330.066895317235, 13333.20000799955, 13371.197728136343, 7358.77923662291, 7388.408927285805, 7398.630068496554, 7438.962805185939, 7463.0, 7026.156861176692, 7028.121484814398, 7074.434045276365, 7095.0, 7095.184053833772, 4408.647308215399, 4479.193745125844, 4486.080353527519, 4518.977405112953, 4521.502634710179, 1717.6822287876782, 1775.6537475192472, 1801.5135913303334, 1842.8709990300817, 1865.5149661087944, 785.2147852147853, 874.7463235661714, 875.7766769473743, 974.3910056214866, 993.1558175550724, 15615.453459128876, 15970.9201453992, 17272.827271727372, 17297.0, 17643.823561764475, 892.8392889279992, 927.8329900617954, 929.3866048408019, 931.9440833550009, 1014.1481155829139, 8725.738227853175, 8970.147835955573, 9050.366474346733, 9216.308776841764, 9250.583723732449, 362817.0, 366878.0, 367903.0, 519664.0, 521080.0, 44557.55442445534, 44945.325820112725, 54563.45436545663, 68597.0, 73701.0, 1009.9949500252599, 1047.2198212331862, 1124.9887501125047, 1171.7246447084929, 1173.3018853781816, 14409.0, 14758.48345307909, 15036.924815376291, 15262.0, 15295.61760955985, 25303.87348063248, 31707.841460792548, 31730.20674483064, 33117.337653246315, 34716.30567388688, 39645.207095857346, 39894.0, 41102.38346424866, 41107.177856443304, 41846.790766045975, 6733.494987875831, 7294.379977701955, 7303.0, 7314.939333796676, 7496.512726672749, 10135.594576217163, 10867.239293249713, 11036.448177591248, 11150.944245279046, 11351.432428378383, 3035.817850928863, 3166.5725127107544, 7180.3537681608905, 9361.672341468016, 9650.903490965282, 9141.63433462654, 9538.380005299634, 9716.75708107303, 9927.553260103168, 9938.403695778277, 9406.576704048472, 9855.753606159904, 9936.503174841084, 9949.303548751517, 10151.94924025375, 7458.73894413693, 7505.249475052451, 7561.886571701319, 7565.8108547284555, 7581.279778421042, 8942.46345219289, 9512.667056652985, 9732.41605503672, 10155.0, 10233.079022887976], "unit": "score", "name": "jquery.html", "value": 7902.770622359657}, {"lowerIsBetter": false, "replicates": [1361.3669643615729, 1405.676694360297, 1435.5119259451785, 1571.2929181868162, 1794.4168145352764, 6960.860782784342, 7511.586862722548, 7689.384849212063, 7694.807629809257, 7726.304632583066, 7523.586202758846, 7663.0, 7720.459567830254, 7727.61361931904, 7735.613219339039, 2036.1244664794133, 2077.5013996640773, 2251.549690061986, 2260.1185537640295, 2285.1430713482446, 2263.8868056597184, 2278.270953294946, 2281.155972290255, 2281.7147856517936, 2282.6461898405773, 2222.0667319725753, 2295.8737269450176, 2300.769923007703, 2301.1255722825304, 2302.7582103879104, 2300.2869110575693, 2322.082777302964, 2325.0699720112007, 2334.8015418689433, 2338.7661233876474, 2307.492351682644, 2331.440454290975, 2339.251439539348, 2351.071326825894, 2357.4931389751114, 7780.183080776494, 7813.726519571845, 7825.217478252186, 7827.530348179127, 7828.412869034845, 4751.0497900419705, 4836.613070954315, 4848.854534363974, 4878.414590249157, 4881.8779530511665, 3229.9677003229904, 3267.9019629411155, 3314.022363402802, 3363.83180840957, 3367.5958884933966, 1118.3848883114335, 1127.7237076916126, 1131.8472006279212, 1133.2973556395004, 1175.4592887271865, 10645.148388128931, 10700.839487407695, 10749.623763168329, 10761.0, 10802.027817496462, 4292.48490181174, 4379.430674012358, 4395.340698895191, 4403.647708183337, 4405.2511073117, 9205.355625106313, 9221.031791661779, 9226.30802689801, 9228.723138305862, 9254.444733316022, 4803.087413391444, 4821.9035619288115, 4844.539768721966, 4847.515248475124, 4847.80608775652, 4436.689431739812, 4450.599446049806, 4456.153330867125, 4458.0, 4461.5092339842595, 3463.8614455422003, 3536.823158842099, 3677.5219221501034, 3683.1712864605784, 3767.1147280389087, 1190.345310079453, 1226.3806777577267, 1228.975420491585, 1230.4647478346947, 1237.7772001039718, 1218.4273391505978, 1220.8840160184768, 1250.1811313589612, 1276.1194775604804, 1300.752856957175, 7224.241454647186, 7301.269873012656, 7308.926910730931, 7320.414366850639, 7353.669084891193, 1109.4619109731773, 1112.8775834658181, 1121.1759356872692, 1121.7363919478917, 1136.9374684392271, 5876.647401155944, 5957.0, 5980.0431930890845, 5981.222441082718, 5982.850428739229, 8733.912660873437, 9056.547172641342, 9071.183593476619, 9163.129502697233, 9337.159655631025, 9030.548472576345, 9066.909330906607, 9077.137671921157, 9078.636854525877, 9087.36388452802, 7243.855122897513, 7322.1945585985495, 7355.448341374418, 7377.40980721541, 7411.888821667571, 7364.66858991336, 7429.8142546436775, 7437.925620743723, 7441.255874412515, 7462.10454745434, 8362.707305244287, 8426.915730842613, 8624.137586241326, 8648.610812513578, 8815.955920220358, 8637.481751094954, 8826.823463530822, 8980.820383592421, 9006.50464224474, 9019.819603608023, 6788.0, 6895.6207408591, 6898.896516552356, 6899.241083480913, 6906.965465172642, 6602.042703808017, 6729.0579318894415, 7147.499675022698, 7326.487145899736, 7330.193678695233, 6871.793846184422, 7033.050538177281, 7057.082579264663, 7095.0, 7249.0213821135585, 6866.34769696878, 6873.415759660485, 6973.6164510952385, 6994.370506654425, 7008.719651213894, 6927.134108236471, 6949.826254343682, 6969.477289203229, 6971.128608923885, 6977.1278590176225, 6350.809475715736, 6447.323031081669, 6488.70800813974, 6509.218893732593, 6530.934690653033, 6574.901376479261, 6605.405513503615, 6622.07290979273, 6628.0, 6630.0], "unit": "score", "name": "mootools.html", "value": 4544.645230333232}, {"lowerIsBetter": false, "replicates": [334.50493269960464, 334.7706820827733, 341.1471321695761, 343.99140021499454, 346.8491206325249, 5758.683272420015, 5858.824235272943, 5859.355470898203, 5880.705964701764, 5904.793332233373, 5633.15502674599, 5778.075507918734, 5788.507976821965, 5810.215620891178, 5820.970895145519, 4478.216312145378, 4526.954730452702, 4537.795799189028, 4538.704984176018, 4544.363789069533, 4342.174986752507, 4436.622887054604, 4458.331250312447, 4463.843765468193, 4535.954640453603, 4425.048614547872, 4432.268675668511, 4474.686771925966, 4475.440569928759, 4505.481869584991, 4496.437945256843, 4508.098380323916, 4511.639068874482, 4512.368268442421, 4512.5261847506035, 3977.085270387798, 3982.5021872265966, 3982.884792258172, 3983.601639836022, 3993.5407428145845, 5394.595405344615, 5478.506934375885, 5547.611667183299, 5589.987604462391, 5599.8880022399735, 5202.4537423570355, 5205.089109405839, 5205.635605507616, 5209.453007434241, 5210.296609957683, 5912.615679980788, 6178.62928224308, 6180.134781130645, 6182.907256391158, 6184.0, 4190.392393103013, 4206.516250631186, 4298.613124818781, 4299.634531064832, 4341.544137865541, 6367.044943258548, 6367.6497792621385, 6423.935760642427, 6429.549931504796, 6439.871202575969, 4414.139242847614, 4421.977890110529, 4422.425084738963, 4426.535213802569, 4430.224710675619, 4326.58897404746, 4466.553344665573, 4470.530594287618, 4479.3057076153245, 4479.731216127043, 5123.385193776696, 5142.305788718475, 5154.252633368141, 5174.482551744795, 5178.6374953752875, 6204.503639708812, 6250.968745156245, 6253.249610046823, 6255.12428260044, 6257.405546473078, 1563.5700182449916, 1574.330909363539, 1584.4692028170462, 1584.952451426459, 1585.2232406120918, 1049.8372752223418, 1060.824963880951, 1069.7432616172218, 1070.1920050362082, 1089.7493576477455, 5861.648301101947, 5862.267216597926, 5875.089361149029, 5875.941240587625, 5880.588358814927, 6353.555251132469, 6413.518986076063, 6419.2296924369375, 6420.101185833987, 6439.54923155384, 5862.970685146547, 5866.178734977107, 5868.882622347529, 5869.295684517885, 5872.236609240771, 3320.3027364253776, 3434.708049815794, 3437.813954185802, 3439.673231043047, 3441.587009558819, 6625.701843417058, 6635.137432133792, 6639.269680335159, 6640.0, 6642.568233064835, 6483.2544257411, 6487.902681459782, 6489.70796314167, 6492.707828147744, 6562.0, 6503.837404064936, 6642.269350371455, 6685.53201275906, 6697.3637504437975, 6703.229128650268, 6176.7838125665385, 6323.7786677466065, 6405.583637063576, 6408.455281301141, 6415.71129299192, 6202.100695399052, 6240.876642204446, 6329.5252856036905, 6348.301686814354, 6353.36466353361, 6617.205935287796, 6669.7665581704405, 6682.431993280626, 6743.190817101783, 6760.526763126534, 4321.827126915014, 4423.292273236267, 4448.733076015449, 4453.287474004143, 4455.7994890229365, 6359.936400636119, 6368.267649220214, 6376.713047912948, 6377.202849643794, 6379.138816259931, 6195.628262304276, 6204.348543402878, 6204.5036397089025, 6204.627722336674, 6207.317195108625, 6043.214382130295, 6181.134641150153, 6185.257769067741, 6189.597676151036, 6195.96902015487, 6076.240469941257, 6086.330503644507, 6096.0855871619615, 6098.664573448503, 6108.57239993214, 6250.06249062626, 6265.154204182377, 6267.905981410191, 6272.655003974825, 6275.058741188858, 5919.644821310735, 6114.969425152845, 6121.693915304128, 6130.601510901777, 6133.877322453615], "unit": "score", "name": "prototype.html", "value": 4683.305916092123}, {"lowerIsBetter": false, "replicates": [753.834156485573, 810.4245985350401, 818.6152508321089, 845.8054647431095, 863.3697400897345, 12513.624591262265, 12520.311382873939, 12624.368781560932, 12634.557790477334, 12662.176958497692, 11802.409879506013, 12021.0, 12589.811152832715, 12640.17838840477, 12646.747065058693, 806.4919100966398, 819.1358117186365, 821.2239433735123, 822.4571782623469, 823.2960818500186, 803.4295650088415, 803.6343463723991, 803.9196080391944, 806.9717559885405, 813.2721214513007, 852.4203541591716, 852.8763329317245, 853.1255463150259, 853.3471894001094, 858.6608289725555, 848.1010129263001, 849.0999540487103, 849.1550906847664, 851.2551517422255, 863.3395452478859, 626.7336382037615, 628.246104674388, 628.3936001758325, 634.6636282770139, 636.8089573128043, 12252.142350035501, 12271.079669024859, 12322.753544929052, 12329.0, 12360.814587781191, 11045.668629941114, 11173.608923687712, 11616.941915290454, 12173.695657608541, 12505.124641275115, 10315.071643552117, 10373.84439233412, 10581.576736930514, 10715.142788576895, 11170.944145279222, 3537.345591065661, 3600.873969411084, 3637.399829028207, 3651.3062518121474, 3654.177809992757, 49079.50920490785, 49229.26156107697, 49814.252786208235, 49905.0, 50019.74990125062, 9448.95275523618, 9509.0, 9583.424994500352, 9584.76038099053, 9830.741489753897, 17494.737578936325, 17518.38685645996, 17577.648447030988, 17586.12069396525, 17634.294628214986, 7687.308142267223, 7796.8050798729355, 7822.647980840876, 7826.0, 7924.564148971746, 4238.470191226097, 4240.406343111967, 4277.957220427756, 4364.4980827204645, 4597.816087356535, 3047.238190452387, 3105.503119500869, 3106.5650808886776, 3108.1452600535035, 3109.751219902402, 558.2603050957498, 559.4042344902666, 560.8597850537366, 577.5379696242989, 579.8057650686983, 611.5566214494456, 650.7266947881901, 670.8545456349809, 676.8747781660409, 690.3855568544, 8269.173082691683, 9808.509574521246, 9810.362326448758, 9998.15015723657, 10002.44986525748, 562.2609645855097, 570.500811789684, 695.2005194026909, 712.6151877985933, 720.6180724216174, 4010.438538604598, 4196.769177695256, 4279.951411904103, 4346.239408103569, 4501.257292546758, 50901.0, 50917.236241456405, 51800.48199518032, 52080.73959630178, 52243.477565224624, 43992.0, 47332.52667473281, 48756.02487950221, 49417.0, 49694.75152624214, 37159.4426083609, 44360.334594981105, 44533.77733111314, 44978.77510612426, 47858.21417858256, 8616.90011389292, 8841.0, 8896.77758056028, 8925.598348074222, 9298.209652179641, 31596.684033159374, 31765.841170794, 34142.65857341494, 34851.825740871136, 35160.0, 43959.560404395546, 44831.32753008773, 46209.76895115637, 46870.76564617155, 47035.529644703114, 11220.66338009861, 11266.0, 11366.261193022427, 11406.543738250377, 11550.59572914944, 12260.816087758512, 12473.313967731861, 12682.619521414372, 12704.237745735285, 13118.540851070167, 11736.413179341169, 11966.714833823171, 11978.161528692908, 12238.326892020668, 12400.441980111096, 11759.235649682743, 12123.575674851338, 12192.51229950792, 12295.815562766387, 12569.057320700802, 11335.773284534429, 11822.763544729229, 11846.881531184577, 11863.0, 12279.570215042431, 9369.203617692572, 9874.582479266675, 10021.599136034769, 10294.433806140734, 10360.274780765274, 8492.830143397221, 9007.459552426875, 9980.500974951368, 10125.493725313852, 10367.7793324005], "unit": "score", "name": "yui.html", "value": 6319.461604957896}], "name": "dromaeo_css", "value": 6816.5649185700295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 105.0, 110.0, 110.0, 109.0, 109.0, 110.0, 102.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.5}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 152.0, 162.0, 126.0, 152.0, 149.0, 126.0, 169.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 159.0, 160.0, 158.0, 164.0, 158.0, 159.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 151.0, 71.0, 72.0, 73.0, 73.0, 152.0, 73.0], "unit": "score", "name": "audio-fft", "value": 88.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 153.0, 96.0, 100.0, 95.0, 143.0, 96.0, 97.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 111.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 55.0, 56.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 88.0, 82.0, 82.0, 84.0, 82.0, 83.0, 82.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [124.0, 115.0, 125.0, 117.0, 116.0, 115.0, 113.0, 120.0, 114.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [153.0, 141.0, 141.0, 144.0, 146.0, 132.0, 137.0, 141.0, 146.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 67.0, 66.0, 68.0, 68.0, 65.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1500.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [188.5014137606032], "unit": "score", "name": "DeltaBlue", "value": 350.7559900000001}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1958.9041095890411], "unit": "score", "name": "RayTrace", "value": 377.7566223776223}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12493.827160493827], "unit": "score", "name": "Boyer", "value": 53.34338241106715}, {"lowerIsBetter": false, "replicates": [42604.166666666664], "unit": "score", "name": "RegExp", "value": 21.382533007334946}, {"lowerIsBetter": false, "replicates": [573.0659025787966], "unit": "score", "name": "Splay", "value": 142.20179499999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18947.906125844638}]} 07:21:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18947.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1500.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6816.57"}}} 07:21:38 INFO - Return code: 0 07:21:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:21:38 INFO - # TBPL SUCCESS # 07:21:38 INFO - Running post-action listener: _resource_record_post_action 07:21:38 INFO - Running post-run listener: _resource_record_post_run 07:21:39 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 317911040; Read time: 104; Write time: 288056 07:21:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20074496; Read time: 0; Write time: 5720 07:21:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 297836544; Read time: 104; Write time: 282336 07:21:39 INFO - Running post-run listener: _upload_blobber_files 07:21:39 INFO - Blob upload gear active. 07:21:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:21:39 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:21:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:21:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:21:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:40 INFO - (blobuploader) - INFO - Done attempting. 07:21:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:21:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:21:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:41 INFO - (blobuploader) - INFO - Done attempting. 07:21:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:21:41 INFO - Return code: 0 07:21:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:21:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:21:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf7f75e54155444dee6d49ac73f540ff1ba812fd865868a351b083e5537bb1816526704a88a4330a1766869aadab9c712de57e24441a787cd1a96fb19a9d8e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03fc1dfc78c28db5f9394f89b4e34dc8372c46a4178c55e51cc308ec88edb227c1c3d15665670b1b41821fbed6721dbccc55354b2e77cf9a74ba226b422498e6"} 07:21:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:21:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:21:41 INFO - Contents: 07:21:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0cf7f75e54155444dee6d49ac73f540ff1ba812fd865868a351b083e5537bb1816526704a88a4330a1766869aadab9c712de57e24441a787cd1a96fb19a9d8e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03fc1dfc78c28db5f9394f89b4e34dc8372c46a4178c55e51cc308ec88edb227c1c3d15665670b1b41821fbed6721dbccc55354b2e77cf9a74ba226b422498e6"} 07:21:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:21:41 INFO - Copying logs to upload dir... 07:21:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:21:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.056887 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-21 07:21:41.807044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 07:21:41.812913) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 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/0cf7f75e54155444dee6d49ac73f540ff1ba812fd865868a351b083e5537bb1816526704a88a4330a1766869aadab9c712de57e24441a787cd1a96fb19a9d8e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03fc1dfc78c28db5f9394f89b4e34dc8372c46a4178c55e51cc308ec88edb227c1c3d15665670b1b41821fbed6721dbccc55354b2e77cf9a74ba226b422498e6"} build_url:https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/HlFOhXVHSY-YrFKuOxJXyQ/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/0cf7f75e54155444dee6d49ac73f540ff1ba812fd865868a351b083e5537bb1816526704a88a4330a1766869aadab9c712de57e24441a787cd1a96fb19a9d8e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03fc1dfc78c28db5f9394f89b4e34dc8372c46a4178c55e51cc308ec88edb227c1c3d15665670b1b41821fbed6721dbccc55354b2e77cf9a74ba226b422498e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 07:21:41.838844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:21:41.839326) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1453388411.673060-491695387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 07:21:41.924652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 07:21:41.925238) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 07:21:41.925770) ========= ========= Total master_lag: 0.30 =========