builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1452697249.77 results: success (0) buildid: 20160113043018 builduid: 08ee6dc53ff34769a794fc8f70502209 revision: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.773772) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.774215) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.774517) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006364 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.805058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.805398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.848310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.848701) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.902136) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.902439) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.906204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:49.906536) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 07:00:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.4M=0s 2016-01-13 07:00:50 (59.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153505 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.077109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.077423) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040055 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.130962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:50.131321) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 --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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 07:00:50,724 truncating revision to first 12 chars 2016-01-13 07:00:50,724 Setting DEBUG logging. 2016-01-13 07:00:50,724 attempt 1/10 2016-01-13 07:00:50,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/531d1f6d1cde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 07:00:50,998 unpacking tar archive at: mozilla-central-531d1f6d1cde/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:51.106265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:51.109665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:51.120618) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:51.120984) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 07:00:51.121427) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 20 secs) (at 2016-01-13 07:00:51.121720) ========= /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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:51 INFO - MultiFileLogger online at 20160113 07:00:51 in /builds/slave/test-pgo 07:00:51 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:51 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:00:51 INFO - {'append_to_log': False, 07:00:51 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:00:51 INFO - 'blob_upload_branch': 'Firefox', 07:00:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:00:51 INFO - 'branch': 'Firefox', 07:00:51 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:51 INFO - 'config_files': ('talos/linux_config.py',), 07:00:51 INFO - 'default_actions': ('clobber', 07:00:51 INFO - 'read-buildbot-config', 07:00:51 INFO - 'download-and-extract', 07:00:51 INFO - 'populate-webroot', 07:00:51 INFO - 'create-virtualenv', 07:00:51 INFO - 'install', 07:00:51 INFO - 'run-tests'), 07:00:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:51 INFO - 'download_minidump_stackwalk': True, 07:00:51 INFO - 'download_symbols': 'ondemand', 07:00:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:51 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:51 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:51 INFO - 'installer_path': 'installer.exe', 07:00:51 INFO - 'log_level': 'info', 07:00:51 INFO - 'log_name': 'talos', 07:00:51 INFO - 'log_to_console': True, 07:00:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:51 INFO - 'opt_config_files': (), 07:00:51 INFO - 'pip_index': False, 07:00:51 INFO - 'sps_profile': False, 07:00:51 INFO - 'sps_profile_interval': 0, 07:00:51 INFO - 'suite': 'dromaeojs', 07:00:51 INFO - 'system_bits': '32', 07:00:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:51 INFO - 'title': 'talos-linux64-ix-015', 07:00:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:51 INFO - 'use_talos_json': True, 07:00:51 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:00:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:51 INFO - 'work_dir': 'build'} 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running clobber step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: clobber 07:00:51 INFO - rmtree: /builds/slave/test-pgo/build 07:00:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:00:56 INFO - Running post-action listener: _resource_record_post_action 07:00:56 INFO - ##### 07:00:56 INFO - ##### Running read-buildbot-config step. 07:00:56 INFO - ##### 07:00:56 INFO - Running pre-action listener: _resource_record_pre_action 07:00:56 INFO - Running main action method: read_buildbot_config 07:00:56 INFO - Using buildbot properties: 07:00:56 INFO - { 07:00:56 INFO - "project": "", 07:00:56 INFO - "product": "firefox", 07:00:56 INFO - "script_repo_revision": "production", 07:00:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:00:56 INFO - "repository": "", 07:00:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:00:56 INFO - "buildid": "20160113043018", 07:00:56 INFO - "pgo_build": "True", 07:00:56 INFO - "basedir": "/builds/slave/test-pgo", 07:00:56 INFO - "buildnumber": 156, 07:00:56 INFO - "slavename": "talos-linux64-ix-015", 07:00:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:00:56 INFO - "platform": "ubuntu64_hw", 07:00:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:00:56 INFO - "branch": "mozilla-central", 07:00:56 INFO - "repo_path": "mozilla-central", 07:00:56 INFO - "revision": "531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601", 07:00:56 INFO - "stage_platform": "linux64-pgo", 07:00:56 INFO - "builduid": "08ee6dc53ff34769a794fc8f70502209", 07:00:56 INFO - "slavebuilddir": "test" 07:00:56 INFO - } 07:00:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:00:56 INFO - Running post-action listener: _resource_record_post_action 07:00:56 INFO - ##### 07:00:56 INFO - ##### Running download-and-extract step. 07:00:56 INFO - ##### 07:00:56 INFO - Running pre-action listener: _resource_record_pre_action 07:00:56 INFO - Running main action method: download_and_extract 07:00:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 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 - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json 07:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json 07:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:00:57 INFO - Downloaded 1448 bytes. 07:00:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:00:57 INFO - Using the following test package requirements: 07:00:57 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:57 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:57 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:57 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'jsshell-linux-x86_64.zip'], 07:00:57 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:57 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:57 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:57 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:57 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:57 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:57 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:57 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:57 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:00:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:01:36 INFO - Downloaded 24029033 bytes. 07:01:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:01:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:01:38 INFO - Return code: 0 07:01:38 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:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:38 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:03:29 INFO - Downloaded 24029033 bytes. 07:03:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 07:03:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:03:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:03:31 INFO - Return code: 0 07:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:31 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:03:45 INFO - Downloaded 11132279 bytes. 07:03:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 07:03:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:03:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:03:45 INFO - Return code: 0 07:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:03:45 INFO - https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:03:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:03:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:03:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:03:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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:07:16 INFO - Downloaded 55876391 bytes. 07:07:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:16 INFO - mkdir: /builds/slave/test-pgo/properties 07:07:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:07:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:07:16 INFO - Contents: 07:07:16 INFO - build_url:https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:16 INFO - Running post-action listener: _resource_record_post_action 07:07:16 INFO - Running post-action listener: set_extra_try_arguments 07:07:16 INFO - ##### 07:07:16 INFO - ##### Running populate-webroot step. 07:07:16 INFO - ##### 07:07:16 INFO - Running pre-action listener: _resource_record_pre_action 07:07:16 INFO - Running main action method: populate_webroot 07:07:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:16 INFO - '--tppagecycles', 07:07:16 INFO - '7'], 07:07:16 INFO - 'tests': ['tsvgm']}}, 07:07:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:07:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'tests': ['damp', 'tps']}, 07:07:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['damp', 'tps']}, 07:07:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:07:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:16 INFO - 'other': {'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'other_l64': {'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'other_nol64': {'tests': ['a11yr', 07:07:16 INFO - 'ts_paint', 07:07:16 INFO - 'tpaint', 07:07:16 INFO - 'sessionrestore', 07:07:16 INFO - 'sessionrestore_no_auto_restore']}, 07:07:16 INFO - 'svgr': {'tests': ['tsvgx', 07:07:16 INFO - 'tsvgr_opacity', 07:07:16 INFO - 'tart', 07:07:16 INFO - 'tscrollx', 07:07:16 INFO - 'cart']}, 07:07:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['tsvgx', 07:07:16 INFO - 'tsvgr_opacity', 07:07:16 INFO - 'tart', 07:07:16 INFO - 'tscrollx', 07:07:16 INFO - 'cart']}, 07:07:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'tests': ['tp5o']}, 07:07:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'talos_options': ['--e10s'], 07:07:16 INFO - 'tests': ['tp5o']}, 07:07:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'talos_options': ['--xperf_path', 07:07:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:16 INFO - 'tests': ['tp5n']}, 07:07:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:16 INFO - 'talos_options': ['--e10s', 07:07:16 INFO - '--xperf_path', 07:07:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:16 INFO - 'tests': ['tp5n']}}, 07:07:16 INFO - 'talos.zip': {'path': '', 07:07:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:16 INFO - Running post-action listener: _resource_record_post_action 07:07:16 INFO - ##### 07:07:16 INFO - ##### Running create-virtualenv step. 07:07:16 INFO - ##### 07:07:16 INFO - Running pre-action listener: _resource_record_pre_action 07:07:16 INFO - Running main action method: create_virtualenv 07:07:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:07:16 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:07:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:07:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:16 INFO - Using real prefix '/usr' 07:07:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:07:17 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:19 INFO - Installing pip.................done. 07:07:19 INFO - Return code: 0 07:07:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:07:19 INFO - Using env: {'DISPLAY': ':0', 07:07:19 INFO - 'HOME': '/home/cltbld', 07:07:19 INFO - 'LANG': 'en_US.UTF-8', 07:07:19 INFO - 'LANGUAGE': 'en_US:en', 07:07:19 INFO - 'LOGNAME': 'cltbld', 07:07:19 INFO - 'MAIL': '/var/mail/cltbld', 07:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:19 INFO - 'MOZ_NO_REMOTE': '1', 07:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:19 INFO - 'NO_EM_RESTART': '1', 07:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:19 INFO - 'SHELL': '/bin/bash', 07:07:19 INFO - 'SHLVL': '1', 07:07:19 INFO - 'TERM': 'linux', 07:07:19 INFO - 'TMOUT': '86400', 07:07:19 INFO - 'USER': 'cltbld', 07:07:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:19 INFO - '_': '/tools/buildbot/bin/python'} 07:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:19 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:07:19 INFO - Cleaning up... 07:07:19 INFO - Return code: 0 07:07:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:07:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:07:19 INFO - Using env: {'DISPLAY': ':0', 07:07:19 INFO - 'HOME': '/home/cltbld', 07:07:19 INFO - 'LANG': 'en_US.UTF-8', 07:07:19 INFO - 'LANGUAGE': 'en_US:en', 07:07:19 INFO - 'LOGNAME': 'cltbld', 07:07:19 INFO - 'MAIL': '/var/mail/cltbld', 07:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:19 INFO - 'MOZ_NO_REMOTE': '1', 07:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:19 INFO - 'NO_EM_RESTART': '1', 07:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:19 INFO - 'SHELL': '/bin/bash', 07:07:19 INFO - 'SHLVL': '1', 07:07:19 INFO - 'TERM': 'linux', 07:07:19 INFO - 'TMOUT': '86400', 07:07:19 INFO - 'USER': 'cltbld', 07:07:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:19 INFO - '_': '/tools/buildbot/bin/python'} 07:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:19 INFO - Downloading/unpacking psutil>=0.7.1 07:07:19 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:07:19 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:07:19 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:07:19 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:07:19 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:07:19 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:07:21 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:07:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:07:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:21 INFO - Installing collected packages: psutil 07:07:21 INFO - Running setup.py install for psutil 07:07:21 INFO - building 'psutil._psutil_linux' extension 07:07:21 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:07:21 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:07:21 INFO - building 'psutil._psutil_posix' extension 07:07:21 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:07:21 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:07:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:22 INFO - Successfully installed psutil 07:07:22 INFO - Cleaning up... 07:07:22 INFO - Return code: 0 07:07:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 07:07:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:07:22 INFO - Using env: {'DISPLAY': ':0', 07:07:22 INFO - 'HOME': '/home/cltbld', 07:07:22 INFO - 'LANG': 'en_US.UTF-8', 07:07:22 INFO - 'LANGUAGE': 'en_US:en', 07:07:22 INFO - 'LOGNAME': 'cltbld', 07:07:22 INFO - 'MAIL': '/var/mail/cltbld', 07:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:22 INFO - 'MOZ_NO_REMOTE': '1', 07:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:22 INFO - 'NO_EM_RESTART': '1', 07:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:22 INFO - 'SHELL': '/bin/bash', 07:07:22 INFO - 'SHLVL': '1', 07:07:22 INFO - 'TERM': 'linux', 07:07:22 INFO - 'TMOUT': '86400', 07:07:22 INFO - 'USER': 'cltbld', 07:07:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:22 INFO - '_': '/tools/buildbot/bin/python'} 07:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:22 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:07:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:07:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:07:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:24 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:07:24 INFO - Installing collected packages: mozsystemmonitor 07:07:24 INFO - Running setup.py install for mozsystemmonitor 07:07:24 INFO - Successfully installed mozsystemmonitor 07:07:24 INFO - Cleaning up... 07:07:24 INFO - Return code: 0 07:07:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:07:24 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:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:24 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:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:24 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:07:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:07:24 INFO - Using env: {'DISPLAY': ':0', 07:07:24 INFO - 'HOME': '/home/cltbld', 07:07:24 INFO - 'LANG': 'en_US.UTF-8', 07:07:24 INFO - 'LANGUAGE': 'en_US:en', 07:07:24 INFO - 'LOGNAME': 'cltbld', 07:07:24 INFO - 'MAIL': '/var/mail/cltbld', 07:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:24 INFO - 'MOZ_NO_REMOTE': '1', 07:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:24 INFO - 'NO_EM_RESTART': '1', 07:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:24 INFO - 'SHELL': '/bin/bash', 07:07:24 INFO - 'SHLVL': '1', 07:07:24 INFO - 'TERM': 'linux', 07:07:24 INFO - 'TMOUT': '86400', 07:07:24 INFO - 'USER': 'cltbld', 07:07:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:24 INFO - '_': '/tools/buildbot/bin/python'} 07:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:24 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:07:24 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:07:24 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:07:24 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:07:24 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:07:24 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:07:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:07:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:07:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:07:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:26 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:07:26 INFO - Downloading docopt-0.6.1.tar.gz 07:07:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:07:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:26 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:26 INFO - Running setup.py install for blobuploader 07:07:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:07:26 INFO - Running setup.py install for requests 07:07:27 INFO - Running setup.py install for docopt 07:07:27 INFO - Successfully installed blobuploader requests docopt 07:07:27 INFO - Cleaning up... 07:07:27 INFO - Return code: 0 07:07:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07: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:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:07:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:27 INFO - Using env: {'DISPLAY': ':0', 07:07:27 INFO - 'HOME': '/home/cltbld', 07:07:27 INFO - 'LANG': 'en_US.UTF-8', 07:07:27 INFO - 'LANGUAGE': 'en_US:en', 07:07:27 INFO - 'LOGNAME': 'cltbld', 07:07:27 INFO - 'MAIL': '/var/mail/cltbld', 07:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:27 INFO - 'MOZ_NO_REMOTE': '1', 07:07:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:27 INFO - 'NO_EM_RESTART': '1', 07:07:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:27 INFO - 'SHELL': '/bin/bash', 07:07:27 INFO - 'SHLVL': '1', 07:07:27 INFO - 'TERM': 'linux', 07:07:27 INFO - 'TMOUT': '86400', 07:07:27 INFO - 'USER': 'cltbld', 07:07:27 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:27 INFO - '_': '/tools/buildbot/bin/python'} 07:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:27 INFO - Running setup.py (path:/tmp/pip-d4nDc6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:27 INFO - Running setup.py (path:/tmp/pip-12ElJ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:27 INFO - Running setup.py (path:/tmp/pip-_h9fM8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:27 INFO - Running setup.py (path:/tmp/pip-Ug3Ib8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:28 INFO - Running setup.py (path:/tmp/pip-fTA_kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:28 INFO - Running setup.py (path:/tmp/pip-nrLTkK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:28 INFO - Running setup.py (path:/tmp/pip-cktnuv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:28 INFO - Running setup.py (path:/tmp/pip-3jqiZA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:28 INFO - Running setup.py (path:/tmp/pip-pFFb6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:28 INFO - Running setup.py (path:/tmp/pip-of04pQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:28 INFO - Running setup.py (path:/tmp/pip-49d9Pr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:28 INFO - Running setup.py (path:/tmp/pip-v_N0f9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:28 INFO - Running setup.py (path:/tmp/pip-XdyeJB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:28 INFO - Running setup.py (path:/tmp/pip-RhRgts-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:28 INFO - Running setup.py (path:/tmp/pip-2c5T6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:28 INFO - Running setup.py (path:/tmp/pip-eUOqRV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:28 INFO - Running setup.py (path:/tmp/pip-My8EsM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:28 INFO - Running setup.py install for manifestparser 07:07:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for mozcrash 07:07:29 INFO - Running setup.py install for mozdebug 07:07:29 INFO - Running setup.py install for mozdevice 07:07:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for mozfile 07:07:29 INFO - Running setup.py install for mozhttpd 07:07:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for mozinfo 07:07:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for mozInstall 07:07:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for mozleak 07:07:29 INFO - Running setup.py install for mozlog 07:07:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:07:29 INFO - Running setup.py install for moznetwork 07:07:30 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Running setup.py install for mozprocess 07:07:30 INFO - Running setup.py install for mozprofile 07:07:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Running setup.py install for mozrunner 07:07:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Running setup.py install for mozscreenshot 07:07:30 INFO - Running setup.py install for moztest 07:07:30 INFO - Running setup.py install for mozversion 07:07:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:07:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:30 INFO - Cleaning up... 07:07:30 INFO - Return code: 0 07:07:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 07:07:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:30 INFO - Using env: {'DISPLAY': ':0', 07:07:30 INFO - 'HOME': '/home/cltbld', 07:07:30 INFO - 'LANG': 'en_US.UTF-8', 07:07:30 INFO - 'LANGUAGE': 'en_US:en', 07:07:30 INFO - 'LOGNAME': 'cltbld', 07:07:30 INFO - 'MAIL': '/var/mail/cltbld', 07:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:30 INFO - 'MOZ_NO_REMOTE': '1', 07:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:30 INFO - 'NO_EM_RESTART': '1', 07:07:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:30 INFO - 'SHELL': '/bin/bash', 07:07:30 INFO - 'SHLVL': '1', 07:07:30 INFO - 'TERM': 'linux', 07:07:30 INFO - 'TMOUT': '86400', 07:07:30 INFO - 'USER': 'cltbld', 07:07:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:30 INFO - '_': '/tools/buildbot/bin/python'} 07:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:30 INFO - Running setup.py (path:/tmp/pip-vzkMLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:30 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:07:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:30 INFO - Running setup.py (path:/tmp/pip-luhiQS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:31 INFO - Running setup.py (path:/tmp/pip-c4EKMq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:31 INFO - Running setup.py (path:/tmp/pip-UDLodf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:31 INFO - Running setup.py (path:/tmp/pip-1Us6KQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:31 INFO - Running setup.py (path:/tmp/pip-fsUBtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:31 INFO - Running setup.py (path:/tmp/pip-O2q4Vz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:31 INFO - Running setup.py (path:/tmp/pip-FmPVQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:31 INFO - Running setup.py (path:/tmp/pip-iGUovV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:31 INFO - Running setup.py (path:/tmp/pip-fVCjIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:31 INFO - Running setup.py (path:/tmp/pip-mPx8hn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:31 INFO - Running setup.py (path:/tmp/pip-xKqMY7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:31 INFO - Running setup.py (path:/tmp/pip-_BLazg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:31 INFO - Running setup.py (path:/tmp/pip-LZa_3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:31 INFO - Running setup.py (path:/tmp/pip-GTrv05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:31 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:07:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:31 INFO - Running setup.py (path:/tmp/pip-04mR7A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:32 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:07:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:32 INFO - Running setup.py (path:/tmp/pip-sHmuZ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:32 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:07:33 INFO - Downloading blessings-1.5.1.tar.gz 07:07:33 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:07:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:33 INFO - Installing collected packages: blessings 07:07:33 INFO - Running setup.py install for blessings 07:07:34 INFO - Successfully installed blessings 07:07:34 INFO - Cleaning up... 07:07:34 INFO - Return code: 0 07:07:34 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:07:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:34 INFO - Reading from file tmpfile_stdout 07:07:34 INFO - Current package versions: 07:07:34 INFO - argparse == 1.2.1 07:07:34 INFO - blessings == 1.5.1 07:07:34 INFO - blobuploader == 1.2.4 07:07:34 INFO - docopt == 0.6.1 07:07:34 INFO - manifestparser == 1.1 07:07:34 INFO - mozInstall == 1.12 07:07:34 INFO - mozcrash == 0.16 07:07:34 INFO - mozdebug == 0.1 07:07:34 INFO - mozdevice == 0.48 07:07:34 INFO - mozfile == 1.2 07:07:34 INFO - mozhttpd == 0.7 07:07:34 INFO - mozinfo == 0.9 07:07:34 INFO - mozleak == 0.1 07:07:34 INFO - mozlog == 3.1 07:07:34 INFO - moznetwork == 0.27 07:07:34 INFO - mozprocess == 0.22 07:07:34 INFO - mozprofile == 0.28 07:07:34 INFO - mozrunner == 6.11 07:07:34 INFO - mozscreenshot == 0.1 07:07:34 INFO - mozsystemmonitor == 0.0 07:07:34 INFO - moztest == 0.7 07:07:34 INFO - mozversion == 1.4 07:07:34 INFO - psutil == 3.1.1 07:07:34 INFO - requests == 1.2.3 07:07:34 INFO - wsgiref == 0.1.2 07:07:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 07:07:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:07:34 INFO - Using env: {'DISPLAY': ':0', 07:07:34 INFO - 'HOME': '/home/cltbld', 07:07:34 INFO - 'LANG': 'en_US.UTF-8', 07:07:34 INFO - 'LANGUAGE': 'en_US:en', 07:07:34 INFO - 'LOGNAME': 'cltbld', 07:07:34 INFO - 'MAIL': '/var/mail/cltbld', 07:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:34 INFO - 'MOZ_NO_REMOTE': '1', 07:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:34 INFO - 'NO_EM_RESTART': '1', 07:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:34 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:34 INFO - 'SHELL': '/bin/bash', 07:07:34 INFO - 'SHLVL': '1', 07:07:34 INFO - 'TERM': 'linux', 07:07:34 INFO - 'TMOUT': '86400', 07:07:34 INFO - 'USER': 'cltbld', 07:07:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:34 INFO - '_': '/tools/buildbot/bin/python'} 07:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 INFO - Cleaning up... 07:07:34 INFO - Return code: 0 07:07:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 07:07:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:07:34 INFO - Using env: {'DISPLAY': ':0', 07:07:34 INFO - 'HOME': '/home/cltbld', 07:07:34 INFO - 'LANG': 'en_US.UTF-8', 07:07:34 INFO - 'LANGUAGE': 'en_US:en', 07:07:34 INFO - 'LOGNAME': 'cltbld', 07:07:34 INFO - 'MAIL': '/var/mail/cltbld', 07:07:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:34 INFO - 'MOZ_NO_REMOTE': '1', 07:07:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:34 INFO - 'NO_EM_RESTART': '1', 07:07:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:34 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:34 INFO - 'SHELL': '/bin/bash', 07:07:34 INFO - 'SHLVL': '1', 07:07:34 INFO - 'TERM': 'linux', 07:07:34 INFO - 'TMOUT': '86400', 07:07:34 INFO - 'USER': 'cltbld', 07:07:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:34 INFO - '_': '/tools/buildbot/bin/python'} 07:07:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:34 INFO - Downloading/unpacking jsonschema 07:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:34 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:07:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:07:36 INFO - Downloading/unpacking functools32 (from jsonschema) 07:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:36 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:07:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:36 INFO - warning: no files found matching '*.txt' 07:07:36 INFO - no previously-included directories found matching 'build' 07:07:36 INFO - no previously-included directories found matching 'dist' 07:07:36 INFO - no previously-included directories found matching '.git*' 07:07:36 INFO - Installing collected packages: jsonschema, functools32 07:07:36 INFO - Running setup.py install for functools32 07:07:36 INFO - warning: no files found matching '*.txt' 07:07:36 INFO - no previously-included directories found matching 'build' 07:07:36 INFO - no previously-included directories found matching 'dist' 07:07:36 INFO - no previously-included directories found matching '.git*' 07:07:36 INFO - Successfully installed jsonschema functools32 07:07:36 INFO - Cleaning up... 07:07:36 INFO - Return code: 0 07:07:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aed2fff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa5630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, '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': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', '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:07:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 07:07:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:07:36 INFO - Using env: {'DISPLAY': ':0', 07:07:36 INFO - 'HOME': '/home/cltbld', 07:07:36 INFO - 'LANG': 'en_US.UTF-8', 07:07:36 INFO - 'LANGUAGE': 'en_US:en', 07:07:36 INFO - 'LOGNAME': 'cltbld', 07:07:36 INFO - 'MAIL': '/var/mail/cltbld', 07:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:36 INFO - 'MOZ_NO_REMOTE': '1', 07:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:36 INFO - 'NO_EM_RESTART': '1', 07:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:36 INFO - 'SHELL': '/bin/bash', 07:07:36 INFO - 'SHLVL': '1', 07:07:36 INFO - 'TERM': 'linux', 07:07:36 INFO - 'TMOUT': '86400', 07:07:36 INFO - 'USER': 'cltbld', 07:07:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:36 INFO - '_': '/tools/buildbot/bin/python'} 07:07:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:37 INFO - Downloading/unpacking flake8 07:07:37 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:07:37 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:07:37 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:07:37 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:07:37 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:07:37 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:07:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:07:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:07:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:07:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:07:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:07:39 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:07:39 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:07:39 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:07:39 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:07:39 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:07:39 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:07:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:07:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:07:39 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:07:39 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:07:39 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:07:39 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:07:39 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:07:39 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:07:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:07:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:07:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:39 INFO - no previously-included directories found matching 'docs/_build' 07:07:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:07:39 INFO - Running setup.py install for pep8 07:07:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:39 INFO - no previously-included directories found matching 'docs/_build' 07:07:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:07:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:07:39 INFO - Cleaning up... 07:07:39 INFO - Return code: 0 07:07:39 INFO - Running post-action listener: _resource_record_post_action 07:07:39 INFO - Running post-action listener: _start_resource_monitoring 07:07:39 INFO - Starting resource monitoring. 07:07:39 INFO - ##### 07:07:39 INFO - ##### Running install step. 07:07:39 INFO - ##### 07:07:39 INFO - Running pre-action listener: _resource_record_pre_action 07:07:39 INFO - Running main action method: install 07:07:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:39 INFO - Reading from file tmpfile_stdout 07:07:39 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:07:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:07:40 INFO - Reading from file tmpfile_stdout 07:07:40 INFO - Output received: 07:07:40 INFO - Usage: mozinstall [options] installer 07:07:40 INFO - Options: 07:07:40 INFO - -h, --help show this help message and exit 07:07:40 INFO - -d DEST, --destination=DEST 07:07:40 INFO - Directory to install application into. [default: 07:07:40 INFO - "/builds/slave/test-pgo"] 07:07:40 INFO - --app=APP Application being installed. [default: firefox] 07:07:40 INFO - mkdir: /builds/slave/test-pgo/build/application 07:07:40 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:07:40 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:07:56 INFO - Reading from file tmpfile_stdout 07:07:56 INFO - Output received: 07:07:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:07:56 INFO - Running post-action listener: _resource_record_post_action 07:07:56 INFO - ##### 07:07:56 INFO - ##### Running run-tests step. 07:07:56 INFO - ##### 07:07:56 INFO - Running pre-action listener: _resource_record_pre_action 07:07:56 INFO - Running main action method: run_tests 07:07:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:07:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:07:56 INFO - Python 2.7.3 07:07:56 INFO - Return code: 0 07:07:56 INFO - grabbing minidump binary from tooltool 07:07: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:07:56 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 0x2b36840>, '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 0x2aa36b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aa3b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:07:56 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:07:56 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:07:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:56 INFO - Return code: 0 07:07:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:07:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:07:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:07:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:07:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:07:57 INFO - Return code: 0 07:07:57 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:07:57 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:07:57 INFO - Using env: {'DISPLAY': ':0', 07:07:57 INFO - 'HOME': '/home/cltbld', 07:07:57 INFO - 'LANG': 'en_US.UTF-8', 07:07:57 INFO - 'LANGUAGE': 'en_US:en', 07:07:57 INFO - 'LOGNAME': 'cltbld', 07:07:57 INFO - 'MAIL': '/var/mail/cltbld', 07:07:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:57 INFO - 'MOZ_NO_REMOTE': '1', 07:07:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:57 INFO - 'NO_EM_RESTART': '1', 07:07:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:57 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:07:57 INFO - 'SHELL': '/bin/bash', 07:07:57 INFO - 'SHLVL': '1', 07:07:57 INFO - 'TERM': 'linux', 07:07:57 INFO - 'TMOUT': '86400', 07:07:57 INFO - 'USER': 'cltbld', 07:07:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895', 07:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:57 INFO - '_': '/tools/buildbot/bin/python'} 07:07:57 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/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:07:57 INFO - mozversion application_buildid: 20160113043018 07:07:57 INFO - mozversion application_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 07:07:57 INFO - mozversion application_display_name: Nightly 07:07:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:57 INFO - mozversion application_name: Firefox 07:07:57 INFO - mozversion application_remotingname: firefox 07:07:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:57 INFO - mozversion application_vendor: Mozilla 07:07:57 INFO - mozversion application_version: 46.0a1 07:07:57 INFO - mozversion platform_buildid: 20160113043018 07:07:57 INFO - mozversion platform_changeset: 531d1f6d1cde1182e9f7f9dff81a4fc5abc0a601 07:07:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:57 INFO - mozversion platform_version: 46.0a1 07:07:57 INFO - using testdate: 1452697677 07:07:57 INFO - actual date: 1452697677 07:07:57 INFO - starting webserver on 'localhost:46716' 07:07:57 INFO - SUITE-START | Running 3 tests 07:07:57 INFO - TEST-START | dromaeo_css 07:07:57 INFO - operating with platform_type : linux_ 07:07:57 INFO - Initialising browser for dromaeo_css test... 07:07:57 INFO - TEST-INFO | started process 25437 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp31mMVX/profile http://localhost:46716/getInfo.html) 07:08:01 INFO - PROCESS | 25437 | __metrics Screen width/height:1600/1200 07:08:01 INFO - PROCESS | 25437 | colorDepth:24 07:08:01 INFO - PROCESS | 25437 | Browser inner width/height: 1024/697 07:08:01 INFO - PROCESS | 25437 | __metrics 07:08:01 INFO - PROCESS | 25437 | 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:08:01 INFO - PROCESS | 25437 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:08:02 INFO - TEST-INFO | 25437: exit 0 07:08:02 INFO - Browser initialized. 07:08:02 INFO - Running cycle 1/1 for dromaeo_css test... 07:08:02 INFO - TEST-INFO | started process 25535 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp31mMVX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:14 INFO - PROCESS | 25535 | RSS: Main: 149975040 07:08:14 INFO - PROCESS | 25535 | 07:09:05 INFO - PROCESS | 25535 | 1452697745717 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:11:13 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46716/tests/dromaeo/cssquery-ext.html) 07:11:14 INFO - PROCESS | 25535 | RSS: Main: 269389824 07:11:14 INFO - PROCESS | 25535 | 07:14:17 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-ext.html (next: http://localhost:46716/tests/dromaeo/cssquery-jquery.html) 07:14:17 INFO - PROCESS | 25535 | RSS: Main: 237215744 07:14:17 INFO - PROCESS | 25535 | 07:17:19 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46716/tests/dromaeo/cssquery-mootools.html) 07:17:20 INFO - PROCESS | 25535 | RSS: Main: 230301696 07:17:20 INFO - PROCESS | 25535 | 07:20:22 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46716/tests/dromaeo/cssquery-prototype.html) 07:20:22 INFO - PROCESS | 25535 | RSS: Main: 215113728 07:20:22 INFO - PROCESS | 25535 | 07:23:25 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46716/tests/dromaeo/cssquery-yui.html) 07:23:26 INFO - PROCESS | 25535 | RSS: Main: 215949312 07:23:26 INFO - PROCESS | 25535 | 07:26:28 INFO - PROCESS | 25535 | Cycle 1(1): loaded http://localhost:46716/tests/dromaeo/cssquery-yui.html (next: http://localhost:46716/tests/dromaeo/cssquery-dojo.html) 07:26:29 INFO - PROCESS | 25535 | RSS: Main: 259149824 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | __start_tp_report 07:26:29 INFO - PROCESS | 25535 | _x_x_mozilla_page_load 07:26:29 INFO - PROCESS | 25535 | _x_x_mozilla_page_load_details 07:26:29 INFO - PROCESS | 25535 | |i|pagename|runs| 07:26:29 INFO - PROCESS | 25535 | |0;dojo.html;3126.9374612507763;3128.9687103128967;3170.1916011417084;3173.412918610057;3211.405889910366;5019.54824065834;5061.772220250088;5072.974635126824;5095.235714642806;5125.666831655944;5142.408623008355;5163.509466600667;5183.6371453998145;5192.688438693681;5226.372835259775;4675.50907154749;4676.36869022681;4689.038747056845;4753.453352864413;4779.28310753388;4817.940053188293;4825.90348193036;4838.782254798525;4850.660453768238;4874.488178741217;4582.839600613979;4663.556962088614;4664.277037059262;4694.507076756926;4712.363830882856;4673.439187297512;4673.906521869543;4678.578927896506;4693.624510039189;4718.056388722235;4545.818167273305;4708.693934894221;4721.5750582447745;4740.5733483986605;4748.691335063209;4931.334269873593;5104.872378190538;5148.845534633967;5171.095058364771;5185.325907632021;5587.497125258706;5591.329040515124;5594.160875868612;5619.578531610146;5620;5606.747696353674;5622.269105016363;5626.634268772516;5637.548996080303;5638.774449022034;5044.596432285409;5116.488351164891;5118.923216151761;5191.558717509016;5264;5690.2887139107615;5708.31500219968;5710.5717071219;5720.599558030981;5766.481016708516;5489.780408783604;5499.7250137492965;5514.117741161475;5517.806876759294;5521.475459831309;5347.010803001457;5381.4349493303425;5486.862828429321;5529.917051244234;5596.048671725816;5466.398696143421;5494.945050549523;5501.724913754297;5505.03661859173;5516.972415137899;5343.251944727741;5505.339359276913;5505.807296744595;5509.173623956359;5553.555715542747;4246.917036155823;4252.914941701149;4266.957330426718;4304.440422745023;4305.225059489259;3834.578196398394;3858.7298889078056;3866.845326186977;3898.5126859142606;3902.31709450845;4961.330220420269;5108.948910510921;5118.923216151761;5127.410347809975;5165.251038599382;5386.811461598825;5388.811391601275;5398.8920221595345;5427.9185812212845;5458.1266997280245;5135.4094279157625;5153.994970980698;5158.613104017214;5164.845054648366;5201.843944681666;4643.6517261205545;4746.572808447257;4759.6668233223345;4765.809367625326;4766.118268120409;5515.227868098469;5727.140928860705;5778.075507918713;5787.855303617359;5837.270341207349;5556.888862222814;5585.972070139624;5588.133839254922;5588.916166257591;5589.245451863946;5564.805231816867;5636.070048441961;5710.5146062585145;5788.7395067222915;5796.449337312949;5418.972905135449;5438.483344082306;5439.211314359475;5443.8094666686475;5486.945130548803;5433.809816656398;5439.972800135974;5441.918371224356;5445.074337362578;5445.727713614224;5143.8456846294675;5233.842984710464;5314.256004159498;5328.227407026037;5390.299261096033;5469.72651367438;5479.835604931858;5485.917711234414;5493.587980901369;5494.5054945055135;5287.154055351125;5341.092014357646;5359.544438722596;5362.65142765719;5434;5301.019311427244;5318.787248510016;5375.086235339923;5386.111291636836;5487.368952570506;5320.920186197288;5324.387695415076;5326.467353264643;5331.040412725747;5331.546818520314 07:26:29 INFO - PROCESS | 25535 | |1;ext.html;534.7887584404162;540.8215288954644;559.5299948043647;562.2409746841764;575.9287724831814;28139.155825325248;28588.14235572931;28605.570916436245;28614;28665.713342866566;36174;36933.445998310046;37102.814485927534;37133.44299835504;37141.814290928574;8587.699430519933;8743.868841967376;8762.86855697165;8765.254953328975;8768;8385.664573417056;8488.405811593191;8490.278326342268;8507.234348908598;8512.404131710782;8322.085920238349;8367.665293388258;8368.832623347529;8576.228139467446;8599.699010534632;8680.392372533894;8735.432196907244;8739.737807865775;8742.038375778659;8744.213020828125;8620.78448038804;8758.080401557809;8763.211310981978;8768.43005204666;8777.824443511157;39579.20841583181;39894.80052599718;40047.59952400497;40067;40108.79945600253;3169.31859650174;3305.3653678575874;3358.882439114619;3394.2193295541915;3834.827432765532;27319;27389.726102739118;27631.723682763117;28381.71618283832;28393.858030709922;3654.196076863086;3721.702263818888;3862.903427414309;3877.7673339599714;3970.086880017583;194667.99999999857;194926;195294;196243;196262;53157.2026419604;60401.39598604046;60860.69569652124;60880.391196087476;60908.69545652332;47449.5255047452;60443.69778151169;61720.69139654273;61727.38272617216;61732.38267617356;14229.573112806633;14446;14542.200178990257;14570.05294655844;14587.41650333996;9318.580663870142;9406.764830879147;10817.350958942488;10847.67456976292;10862.674119776419;19475.083686287613;20176.09207585662;20304.28934987298;20329.18683252683;20347.08438120288;7886.723964661324;7909.604519773989;8034.38452696289;8067.556284404414;8095.433319667567;995.9402435853872;1002.6240159940022;1022.9130523905551;1024.2881197567767;1059.86751656043;27456.45087098247;28289.71710282871;31133;32834.671653283636;33172.66827331744;986.1469828598355;1000.3897622450299;1005.9195264378832;1066.4188017530464;1077.4289626497969;14988;15003.849961500464;15047.623809404853;15166.24168791556;15179.696406072038;379624;382424;383956;384069;384814;54194.72902635462;54705.45294547083;54747.45252547503;54791.45208547863;54859;1340.9329533523285;1355.4984655677265;1367.1387026173447;1390.8052872597843;1391.7842734376188;27624.447511049264;28372.290692732022;28722;28741.137765867057;28763.712362876104;46482.53517464782;46704.065918682114;46866.53133468758;46912.53087469218;46928.061438771714;284661;286884;287019;287427;287676;27403.17790466289;30948.381032379675;32240.83879580587;32424.675753243107;32502.674973249967;36920.70777522774;37402.41871965458;37935.43096853494;37938;38128.428073579475;31635.36729265448;32147.517787232744;32420.513692294164;32856.01431957045;33048.50427243545;32780.50829237611;33082;33256.1685957853;33469.66530334763;35328.29343413169;33732.3253534923;33974;33989.49015764815;34022;34534.30931381408;29643.703562964096;31226.843865780527;31415.371692565564;31695;31711.36577268488;23608.29175124749;23666.88166559225;23785.405364866016;23929.162479313836;24158.51682966366 07:26:29 INFO - PROCESS | 25535 | |2;jquery.html;352.5962772625344;354.30202501072876;358.73724489795933;361.6148801526374;363.32240371706774;13321.733565328688;13802.102863313878;15622.531324060283;15981.440649577253;17070.2318395672;15406;15575.454859079906;16602;16726.24731887065;16758.664826703458;4980.875478113049;5388.43421440749;5390.1375779875225;5403.567714582844;5407.702576358299;3973.9205215895663;4122.546519882811;5264.657797243186;5754.65472071675;5972.73122709477;5479.397266300703;5895.705214739246;5914;5935.792247271324;5937.317208521011;5379.112446446332;5600.971995140018;5626.212330273765;5641.746121424546;5642.689652069134;5253.185756207794;5278.419373868871;5279.1817268323475;5287.233351164098;5293.020791153611;12221.144519883612;12414.379281035912;12645.620631381073;12691.682707932376;12698.365081745967;1960.304092047317;2018.6467368210504;2038.6941958706163;2045.427280361501;2164.296058243567;9209.631614735403;9410.200132988704;9482.762930926712;11631.47658355376;12146.271223726604;1816.927322907082;1819.4450692538771;1897.3169658922777;1922.3656193456127;2009.8090681385245;46866.06267874623;48895.511044889805;48977.26534101991;49054.26418603724;49109.50890491085;9403.90596094044;9573.760655983517;9575.856362154573;9595.616175353047;9642.566084526214;12650.114491985472;12667.429965651569;12680.873191267969;12705.682357940941;12740.490380384867;6691.297413771581;6741;6776.93223067763;6799.660016999229;6977.616231107237;6302.590331628429;6326.715297811609;6527.510436717265;6596.571222870498;6598.307177746267;3919.2161567686576;4218.978905105516;4220.6412454941055;4235.708109026777;4243.384709217146;1675.899446033242;1697.516207880748;1764.6911790436623;1783.8840475369059;1803.4769916724003;814.2918143811921;858.9098144694717;883.5140672630027;884.4207044385809;886.4326830828275;13170.47318107284;14881;15653.921730391276;16078.919605401898;16506.504804855875;795.2326005404813;859.7979474823411;904.7873749668822;951.2342564235719;971.1939090554822;5643.506522683335;5886.735096920564;5979.222701048836;7261.41908647307;9202.677906273248;440203;497641;497880;543970;549864;72577.6371118141;73054;75632.24367756362;76107;76426.23573764303;508.8829569199105;517.6945602094706;521.4759167037104;523.3092318140094;523.3876364653364;9938.602455901682;10434;10506.947465262625;10512.894871051498;10513.89486105129;30778;32873;33305;33358.16604584905;33528.832355838065;45674.62976110722;45686.08627827491;47208.76395618;48526.272105917735;48928.75535622299;9206.723798286062;9914.801703966024;9947.204223662235;10286.794264114526;10302.896971030194;11605.883941160819;11753.941230293794;11816;11884.168108232341;12167.2699638022;9443.386179898285;9823.607055717977;9962.800743984935;9985.900140998498;10080.193584513368;10288.742781430525;10447.94776026115;10709.250352475252;10841.891581084088;10846.240763146505;7146.100380706078;9094.954525227331;9316.673916412892;9774.609015639579;9802.068803463944;9555.569999350186;9922.900770992197;10038.849417258893;10155.086042256233;10182.847257291294;6878.071460352789;9631.036896310314;10031.498425078862;10212.285140040125;10213.642522511676 07:26:29 INFO - PROCESS | 25535 | |3;mootools.html;1278.303324688045;1374.780035194369;1383.88236999855;1506.1866592040299;1774.0420173106522;6633.1376921000265;7720.150783413827;7877.921220787791;7886.408519361056;7886.960565197166;7650.770476885702;7806.960965195166;7823.374130069595;7827.843443131134;7841.960790196055;1930.0735646889432;1981.7522809648794;2261.7851304126084;2333.404981729661;2358.469344397514;2313.375388645065;2322.6516022596575;2336.789688927996;2339.6958395408574;2341.812654987597;2175.1082056356895;2252.7296724393095;2257.24382331919;2258.9096436142618;2260.028187879211;2295.7130358705163;2314.456102815837;2333.323336232499;2347.9530409391887;2348.5537747827857;2292.5414917016665;2301.4131396493954;2323.6398358254496;2327.6624889391114;2330.370799884022;7697.692092316301;7754.302112809874;7765.184655611192;7767.223277672244;7793.1817159198035;4794.736289504076;4895.510448955076;4929.334539837112;4948.0846043481715;4950.603951683856;2989.289046091517;3011.578379026938;3064.647565529948;3068.202267410467;3074.923126921845;916.702071826659;929.9581518831601;938.2259635800424;942.7878727286375;967.908048735369;10895.509702063426;10899.618513351994;10911.399873006982;10924.617638382619;10958.01377875987;4316.611504964569;4371.213181627274;4387.670924680598;4424.159409712144;4430.468343798765;8957.731268061969;8959.641614335354;8964.506952117566;8965.193132618097;8967.551622418852;4877.341558889504;4913.828016019422;4925.630577706686;4927.7536123193695;4939.185034469272;4414.1171765647;4429.82280708768;4432;4432.29083346663;4464.888377790517;3370.612379576331;3435.278591495814;3435.4331535296897;3435.4675025371107;3645.7265705072227;1214.4595654933646;1221.2001139253803;1223.663492539541;1236.8763123687559;1237.8514578250488;1309.2798960571647;1309.7118633900718;1325.6420766393019;1340.0753480098701;1357.9932100339436;7293.380062694624;7350.117985841734;7502.62486875654;7503.399728021745;7513.098428188652;1104.4091411095026;1117.8435019097333;1118.692359601116;1125.9732085776013;1139.9145064120057;5853.326867410217;5879.265091863517;5937.317208520989;5942.61373010753;5946.643201407929;9068.138526839939;9275;9301.069893010645;9426.62293508252;9459.290553208537;9240.95379523098;9363.063693630582;9370.62517499306;9373.015833337538;9384.390014649027;7261.564306141649;7309.378702810321;7351.558906465629;7414.777556673308;7433.442491813135;7360.33756961876;7430.851382972202;7476.177620461636;7478.588677622783;7481.700731970878;8178.223068808454;8368.497890126611;8431.19903609156;8602.82794344097;8605.182507661762;8390.202930721573;8533.74398768038;8693.782655433664;8694.956525217334;8711.56442177876;6992.1259842519685;7066.152061752623;7077.469189810682;7098.006279120824;7102.786916392516;6373.426391624776;6546.738130474918;6552.705128269335;6558.409743123142;7392.37164840973;6383.297837237993;6428.935710642833;6869.862602748017;6889.621070841152;7007.7196912122945;6553.836154096186;6575.539712220098;6595.703193356215;6687.130673012672;6880.208775990825;6954.582725036514;7009.228984811564;7022.719091236293;7024.086868707035;7024.894626580503;6430;6585.176852893388;6610.4050635443045;6622.470202383702;6630.038644396632;6645.069690243273;6679.031540426514;6680.63256520896;6681.699323530355;6683.7660681875905 07:26:29 INFO - PROCESS | 25535 | |4;prototype.html;329.99340013199736;330.87426777824425;334.37138180221183;340.86024729860753;341.52186938286394;5650.434956504358;5820.708964551766;5822.621529600573;5859.501942334901;5860.765569377219;5620.437956204378;5758.193852860592;5759.049756790125;5770.884582308351;5771.394003629622;4457.554244575549;4483.574060464267;4508.864734057967;4514.210013247685;4528.18492671319;4338.370936214247;4412.47050353958;4442.955570444303;4521.163584736834;4526;4490.7081039732475;4492.168948744493;4506.076254367863;4512.1426928883575;4512.2329204035395;4462.910741785162;4494.1910456117885;4502.347159661831;4506.3465797459185;4507.5267096955;3951;3973.304671682473;3974.920501589981;3981.442598036277;3984.203159368138;5438.157085651691;5583.972080139614;5612.719364031782;5615.101583746581;5621.690807005613;5118.795248190068;5151.253068305112;5152.355955505562;5160.716160611165;5163.380394352665;5821.50517206038;6137.079438084323;6139.693015349215;6147.661878596676;6148.7233074511305;4146.813393397304;4170.291050521389;4236.301010333292;4246.299360605496;4252.957470425287;6302.086197501382;6394.552381333308;6398.648074355862;6398.9040164397575;6401.967990160019;4317.956820431756;4318.568143185719;4320.481542214954;4320.611144996966;4323.805428755713;4236.597523235288;4368.759718215465;4375.824967001348;4377.627901628333;4381.912361752811;5056.469070747518;5062;5065.265536497187;5068.594512438996;5072.087024335655;6189.721462534197;6190.721417536131;6194.938050619527;6197.318294987548;6198.380161983766;1549.7830303757257;1581.122477025239;1581.343742346936;1581.5808810665183;1582.1298285942685;1040.1366865501616;1044.6187141693226;1046.2937517175876;1046.5186014433293;1072.7425417899804;5778.930897783924;5794.101914203306;5802.506786923074;5813.7383817728305;5822.184894114827;6362.491000719931;6363.395477429637;6376.968115159488;6381.329960354189;6385.233771947396;5821.941780582225;5825.271841019872;5827.854303642443;5828.504577110908;5828.708564571754;3338.716209122203;3440.0539851540525;3443.6384179661277;3448.9655103449145;3449.344624521333;6573.901391479131;6638.800835974928;6638.933610663831;6646.900296495556;6650.667466626649;6482.57863238888;6484.740610375627;6488;6491.837704057436;6500.4799616030605;6507.157181384387;6564.113844631009;6597;6614.503912206507;6617.867642647217;6213.068039794067;6311.053341998737;6339.683015849281;6345.302016778059;6350.809475715736;6146.170267014075;6299.6535190564955;6315.368463153648;6324.905126423016;6366.427021568081;6653.933460665525;6654.600723956578;6659.700313485808;6675.7997260082275;6697.3637504437;4245.639120674654;4451.020775429401;4451.1765323415275;4455.2426087564545;4457.064016556559;6354.714037868214;6357.491400687842;6358.109864619049;6366.6180029198395;6370.885095108245;6194.783182588588;6200.627962322275;6213.099100630474;6215.81352559424;6216.720247588779;6069.757209711562;6217.96891015542;6236.064590311489;6260.7495700171485;6266.279377871603;6155.784547540815;6157.476614487639;6159.969200153971;6162.075688646739;6162.506999439945;6302.401271879165;6341.365863413806;6358.459530939737;6374.107624932606;6377.298497165215;6058.485028772604;6091.5126789857595;6145.8156255312415;6147.139400483847;6156.230471191101 07:26:29 INFO - PROCESS | 25535 | |5;yui.html;736.2858027713116;783.4202690009392;813.585071613477;823.3824631526355;831.6091437024596;12717.17338373005;12883.871161288384;12892.742145157092;12913.80629290559;12955.80566291504;12584.874151258484;12653.114282000264;12654.367281635927;12660.62018139455;12662.303573303465;661.7452280871851;674.0832467843728;804.6258489802241;821.4578378270343;825.1047613339534;821.8397412504564;826.2316046077145;828.958552072397;829.5437509369852;830.5058490198322;853.6542700206427;859.8925134358205;860.9053004169537;861.3023451004675;863.115306810518;684.7226873116371;694.8610277944406;847.5889193741;859.9398042137053;863.3611127765471;630.6184758221302;632.9620222786648;633.1768700689086;633.7148283272546;633.787681126823;11703;11833.763324733543;11857.288562686266;11879.346635935106;11880.702982425422;12521.499140034388;12950.417231224617;12953.805692914613;13211.339433028406;13257.138286011475;10167.237457190666;10199.4390308533;10480.580776768997;10685.091767199798;10821.567137314498;3607.482848085885;3624.1483251435893;3631.1103779574173;3668.4313931340416;3771.113788259784;45375.773121134516;45594.54405455936;45667.314990275176;46231.76884115558;46332.3050154248;9713.989699245896;9999.450030248407;10022.899771002343;10104.898951010542;10175.440350780778;17294.827051729575;17495.737563936553;17498.212580433657;17503.47489575315;17516.912415438095;6811.523193376515;6845.349691779273;6975.6163411012885;7037.120359955005;7158.105236845395;4333.068390296102;4388.71473354231;4394.648428125743;4415.094905544356;4427.845025424094;3015.261260991071;3047.9542806857917;3058.204866734665;3063.1423201503617;3067.371188906269;562.0922210629885;564.9943500565024;567.3617180671745;576.1242910775597;598.8023952095798;493.88393727474016;497.3608912547359;506.5643546549964;524.0828550037435;606.5602438232246;7554.848903022019;7602.42981776369;7770.805729856799;8012.399070069768;8109.59452027408;587.6386022596158;610.2737742086903;681;701.5019336271305;716.6810769207757;3302.570665813477;3347.5132190990803;3420.675035871588;3497.3529896969144;3550.2544465661986;52302.47697523052;52734;52921.7353913228;52927.47072529225;53098;45726.77136614296;45759.08481830345;45983;46039.53960460419;46382.30426543605;43406.13187736228;44000.3399949001;44784.552154478035;44819;45093.323600146025;7423.740169094056;7600.771976840703;7616.35261002821;7621.466497345133;7649.31156195945;32448;32497.837510812296;33082.5037624431;33201.66798331986;33671;40401;40573;43591.56408436002;43688.56311436845;43952.78023609862;9514.286428517751;9636.855447168158;9895.723983483695;9988.158111693514;10002.599896004078;11073.808887172441;11131.72170695739;11141.665750027512;11449.42752862337;11925.701857453632;9969.252306076929;10339.534720937425;10479.790404192026;10701.304415212986;10950.616728414467;11176.217664763388;11373.54505819758;11521;11548.307101573933;11861.703457413289;9280.814383712423;9626.892907315749;10385.480725963822;10404.947975260075;10421.166306695597;6182.629042257479;8519.701810436605;8621.784455388666;8978.775530611787;9168.541572921195;8737.78155546091;8810.471371717718;8881.911180888366;8973.641054357753;9076.636934522545 07:26:29 INFO - PROCESS | 25535 | __end_tp_report 07:26:29 INFO - PROCESS | 25535 | __start_cc_report 07:26:29 INFO - PROCESS | 25535 | _x_x_mozilla_cycle_collect,1005 07:26:29 INFO - PROCESS | 25535 | __end_cc_report 07:26:29 INFO - PROCESS | 25535 | __startTimestamp1452698789013__endTimestamp 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | ------- Summary: start ------- 07:26:29 INFO - PROCESS | 25535 | Number of tests: 6 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#0] dojo.html Cycles:165 Average:5135.05 Median:5324.39 stddev:554.66 (10.4%) stddev-sans-first:533.52 07:26:29 INFO - PROCESS | 25535 | Values: 3126.9 3129.0 3170.2 3173.4 3211.4 5019.5 5061.8 5073.0 5095.2 5125.7 5142.4 5163.5 5183.6 5192.7 5226.4 4675.5 4676.4 4689.0 4753.5 4779.3 4817.9 4825.9 4838.8 4850.7 4874.5 4582.8 4663.6 4664.3 4694.5 4712.4 4673.4 4673.9 4678.6 4693.6 4718.1 4545.8 4708.7 4721.6 4740.6 4748.7 4931.3 5104.9 5148.8 5171.1 5185.3 5587.5 5591.3 5594.2 5619.6 5620.0 5606.7 5622.3 5626.6 5637.5 5638.8 5044.6 5116.5 5118.9 5191.6 5264.0 5690.3 5708.3 5710.6 5720.6 5766.5 5489.8 5499.7 5514.1 5517.8 5521.5 5347.0 5381.4 5486.9 5529.9 5596.0 5466.4 5494.9 5501.7 5505.0 5517.0 5343.3 5505.3 5505.8 5509.2 5553.6 4246.9 4252.9 4267.0 4304.4 4305.2 3834.6 3858.7 3866.8 3898.5 3902.3 4961.3 5108.9 5118.9 5127.4 5165.3 5386.8 5388.8 5398.9 5427.9 5458.1 5135.4 5154.0 5158.6 5164.8 5201.8 4643.7 4746.6 4759.7 4765.8 4766.1 5515.2 5727.1 5778.1 5787.9 5837.3 5556.9 5586.0 5588.1 5588.9 5589.2 5564.8 5636.1 5710.5 5788.7 5796.4 5419.0 5438.5 5439.2 5443.8 5486.9 5433.8 5440.0 5441.9 5445.1 5445.7 5143.8 5233.8 5314.3 5328.2 5390.3 5469.7 5479.8 5485.9 5493.6 5494.5 5287.2 5341.1 5359.5 5362.7 5434.0 5301.0 5318.8 5375.1 5386.1 5487.4 5320.9 5324.4 5326.5 5331.0 5331.5 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#1] ext.html Cycles:180 Average:45075.73 Median:33981.75 stddev:78586.89 (231.3%) stddev-sans-first:78736.19 07:26:29 INFO - PROCESS | 25535 | Values: 534.8 540.8 559.5 562.2 575.9 28139.2 28588.1 28605.6 28614.0 28665.7 36174.0 36933.4 37102.8 37133.4 37141.8 8587.7 8743.9 8762.9 8765.3 8768.0 8385.7 8488.4 8490.3 8507.2 8512.4 8322.1 8367.7 8368.8 8576.2 8599.7 8680.4 8735.4 8739.7 8742.0 8744.2 8620.8 8758.1 8763.2 8768.4 8777.8 39579.2 39894.8 40047.6 40067.0 40108.8 3169.3 3305.4 3358.9 3394.2 3834.8 27319.0 27389.7 27631.7 28381.7 28393.9 3654.2 3721.7 3862.9 3877.8 3970.1 194668.0 194926.0 195294.0 196243.0 196262.0 53157.2 60401.4 60860.7 60880.4 60908.7 47449.5 60443.7 61720.7 61727.4 61732.4 14229.6 14446.0 14542.2 14570.1 14587.4 9318.6 9406.8 10817.4 10847.7 10862.7 19475.1 20176.1 20304.3 20329.2 20347.1 7886.7 7909.6 8034.4 8067.6 8095.4 995.9 1002.6 1022.9 1024.3 1059.9 27456.5 28289.7 31133.0 32834.7 33172.7 986.1 1000.4 1005.9 1066.4 1077.4 14988.0 15003.8 15047.6 15166.2 15179.7 379624.0 382424.0 383956.0 384069.0 384814.0 54194.7 54705.5 54747.5 54791.5 54859.0 1340.9 1355.5 1367.1 1390.8 1391.8 27624.4 28372.3 28722.0 28741.1 28763.7 46482.5 46704.1 46866.5 46912.5 46928.1 284661.0 286884.0 287019.0 287427.0 287676.0 27403.2 30948.4 32240.8 32424.7 32502.7 36920.7 37402.4 37935.4 37938.0 38128.4 31635.4 32147.5 32420.5 32856.0 33048.5 32780.5 33082.0 33256.2 33469.7 35328.3 33732.3 33974.0 33989.5 34022.0 34534.3 29643.7 31226.8 31415.4 31695.0 31711.4 23608.3 23666.9 23785.4 23929.2 24158.5 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#2] jquery.html Cycles:180 Average:26156.20 Median:49015.76 stddev:82983.99 (169.3%) stddev-sans-first:83194.16 07:26:29 INFO - PROCESS | 25535 | Values: 352.6 354.3 358.7 361.6 363.3 13321.7 13802.1 15622.5 15981.4 17070.2 15406.0 15575.5 16602.0 16726.2 16758.7 4980.9 5388.4 5390.1 5403.6 5407.7 3973.9 4122.5 5264.7 5754.7 5972.7 5479.4 5895.7 5914.0 5935.8 5937.3 5379.1 5601.0 5626.2 5641.7 5642.7 5253.2 5278.4 5279.2 5287.2 5293.0 12221.1 12414.4 12645.6 12691.7 12698.4 1960.3 2018.6 2038.7 2045.4 2164.3 9209.6 9410.2 9482.8 11631.5 12146.3 1816.9 1819.4 1897.3 1922.4 2009.8 46866.1 48895.5 48977.3 49054.3 49109.5 9403.9 9573.8 9575.9 9595.6 9642.6 12650.1 12667.4 12680.9 12705.7 12740.5 6691.3 6741.0 6776.9 6799.7 6977.6 6302.6 6326.7 6527.5 6596.6 6598.3 3919.2 4219.0 4220.6 4235.7 4243.4 1675.9 1697.5 1764.7 1783.9 1803.5 814.3 858.9 883.5 884.4 886.4 13170.5 14881.0 15653.9 16078.9 16506.5 795.2 859.8 904.8 951.2 971.2 5643.5 5886.7 5979.2 7261.4 9202.7 440203.0 497641.0 497880.0 543970.0 549864.0 72577.6 73054.0 75632.2 76107.0 76426.2 508.9 517.7 521.5 523.3 523.4 9938.6 10434.0 10506.9 10512.9 10513.9 30778.0 32873.0 33305.0 33358.2 33528.8 45674.6 45686.1 47208.8 48526.3 48928.8 9206.7 9914.8 9947.2 10286.8 10302.9 11605.9 11753.9 11816.0 11884.2 12167.3 9443.4 9823.6 9962.8 9985.9 10080.2 10288.7 10447.9 10709.3 10841.9 10846.2 7146.1 9095.0 9316.7 9774.6 9802.1 9555.6 9922.9 10038.8 10155.1 10182.8 6878.1 9631.0 10031.5 10212.3 10213.6 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#3] mootools.html Cycles:180 Average:5468.43 Median:6553.27 stddev:2816.39 (43.0%) stddev-sans-first:2806.67 07:26:29 INFO - PROCESS | 25535 | Values: 1278.3 1374.8 1383.9 1506.2 1774.0 6633.1 7720.2 7877.9 7886.4 7887.0 7650.8 7807.0 7823.4 7827.8 7842.0 1930.1 1981.8 2261.8 2333.4 2358.5 2313.4 2322.7 2336.8 2339.7 2341.8 2175.1 2252.7 2257.2 2258.9 2260.0 2295.7 2314.5 2333.3 2348.0 2348.6 2292.5 2301.4 2323.6 2327.7 2330.4 7697.7 7754.3 7765.2 7767.2 7793.2 4794.7 4895.5 4929.3 4948.1 4950.6 2989.3 3011.6 3064.6 3068.2 3074.9 916.7 930.0 938.2 942.8 967.9 10895.5 10899.6 10911.4 10924.6 10958.0 4316.6 4371.2 4387.7 4424.2 4430.5 8957.7 8959.6 8964.5 8965.2 8967.6 4877.3 4913.8 4925.6 4927.8 4939.2 4414.1 4429.8 4432.0 4432.3 4464.9 3370.6 3435.3 3435.4 3435.5 3645.7 1214.5 1221.2 1223.7 1236.9 1237.9 1309.3 1309.7 1325.6 1340.1 1358.0 7293.4 7350.1 7502.6 7503.4 7513.1 1104.4 1117.8 1118.7 1126.0 1139.9 5853.3 5879.3 5937.3 5942.6 5946.6 9068.1 9275.0 9301.1 9426.6 9459.3 9241.0 9363.1 9370.6 9373.0 9384.4 7261.6 7309.4 7351.6 7414.8 7433.4 7360.3 7430.9 7476.2 7478.6 7481.7 8178.2 8368.5 8431.2 8602.8 8605.2 8390.2 8533.7 8693.8 8695.0 8711.6 6992.1 7066.2 7077.5 7098.0 7102.8 6373.4 6546.7 6552.7 6558.4 7392.4 6383.3 6428.9 6869.9 6889.6 7007.7 6553.8 6575.5 6595.7 6687.1 6880.2 6954.6 7009.2 7022.7 7024.1 7024.9 6430.0 6585.2 6610.4 6622.5 6630.0 6645.1 6679.0 6680.6 6681.7 6683.8 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#4] prototype.html Cycles:180 Average:5165.43 Median:5821.11 stddev:1555.49 (26.7%) stddev-sans-first:1516.93 07:26:29 INFO - PROCESS | 25535 | Values: 330.0 330.9 334.4 340.9 341.5 5650.4 5820.7 5822.6 5859.5 5860.8 5620.4 5758.2 5759.0 5770.9 5771.4 4457.6 4483.6 4508.9 4514.2 4528.2 4338.4 4412.5 4443.0 4521.2 4526.0 4490.7 4492.2 4506.1 4512.1 4512.2 4462.9 4494.2 4502.3 4506.3 4507.5 3951.0 3973.3 3974.9 3981.4 3984.2 5438.2 5584.0 5612.7 5615.1 5621.7 5118.8 5151.3 5152.4 5160.7 5163.4 5821.5 6137.1 6139.7 6147.7 6148.7 4146.8 4170.3 4236.3 4246.3 4253.0 6302.1 6394.6 6398.6 6398.9 6402.0 4318.0 4318.6 4320.5 4320.6 4323.8 4236.6 4368.8 4375.8 4377.6 4381.9 5056.5 5062.0 5065.3 5068.6 5072.1 6189.7 6190.7 6194.9 6197.3 6198.4 1549.8 1581.1 1581.3 1581.6 1582.1 1040.1 1044.6 1046.3 1046.5 1072.7 5778.9 5794.1 5802.5 5813.7 5822.2 6362.5 6363.4 6377.0 6381.3 6385.2 5821.9 5825.3 5827.9 5828.5 5828.7 3338.7 3440.1 3443.6 3449.0 3449.3 6573.9 6638.8 6638.9 6646.9 6650.7 6482.6 6484.7 6488.0 6491.8 6500.5 6507.2 6564.1 6597.0 6614.5 6617.9 6213.1 6311.1 6339.7 6345.3 6350.8 6146.2 6299.7 6315.4 6324.9 6366.4 6653.9 6654.6 6659.7 6675.8 6697.4 4245.6 4451.0 4451.2 4455.2 4457.1 6354.7 6357.5 6358.1 6366.6 6370.9 6194.8 6200.6 6213.1 6215.8 6216.7 6069.8 6218.0 6236.1 6260.7 6266.3 6155.8 6157.5 6160.0 6162.1 6162.5 6302.4 6341.4 6358.5 6374.1 6377.3 6058.5 6091.5 6145.8 6147.1 6156.2 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - PROCESS | 25535 | [#5] yui.html Cycles:180 Average:12954.94 Median:45871.04 stddev:14871.88 (32.4%) stddev-sans-first:14885.29 07:26:29 INFO - PROCESS | 25535 | Values: 736.3 783.4 813.6 823.4 831.6 12717.2 12883.9 12892.7 12913.8 12955.8 12584.9 12653.1 12654.4 12660.6 12662.3 661.7 674.1 804.6 821.5 825.1 821.8 826.2 829.0 829.5 830.5 853.7 859.9 860.9 861.3 863.1 684.7 694.9 847.6 859.9 863.4 630.6 633.0 633.2 633.7 633.8 11703.0 11833.8 11857.3 11879.3 11880.7 12521.5 12950.4 12953.8 13211.3 13257.1 10167.2 10199.4 10480.6 10685.1 10821.6 3607.5 3624.1 3631.1 3668.4 3771.1 45375.8 45594.5 45667.3 46231.8 46332.3 9714.0 9999.5 10022.9 10104.9 10175.4 17294.8 17495.7 17498.2 17503.5 17516.9 6811.5 6845.3 6975.6 7037.1 7158.1 4333.1 4388.7 4394.6 4415.1 4427.8 3015.3 3048.0 3058.2 3063.1 3067.4 562.1 565.0 567.4 576.1 598.8 493.9 497.4 506.6 524.1 606.6 7554.8 7602.4 7770.8 8012.4 8109.6 587.6 610.3 681.0 701.5 716.7 3302.6 3347.5 3420.7 3497.4 3550.3 52302.5 52734.0 52921.7 52927.5 53098.0 45726.8 45759.1 45983.0 46039.5 46382.3 43406.1 44000.3 44784.6 44819.0 45093.3 7423.7 7600.8 7616.4 7621.5 7649.3 32448.0 32497.8 33082.5 33201.7 33671.0 40401.0 40573.0 43591.6 43688.6 43952.8 9514.3 9636.9 9895.7 9988.2 10002.6 11073.8 11131.7 11141.7 11449.4 11925.7 9969.3 10339.5 10479.8 10701.3 10950.6 11176.2 11373.5 11521.0 11548.3 11861.7 9280.8 9626.9 10385.5 10404.9 10421.2 6182.6 8519.7 8621.8 8978.8 9168.5 8737.8 8810.5 8881.9 8973.6 9076.6 07:26:29 INFO - PROCESS | 25535 | -------- Summary: end -------- 07:26:29 INFO - PROCESS | 25535 | 07:26:29 INFO - TEST-INFO | 25535: exit 0 07:26:29 INFO - TEST-OK | dromaeo_css | took 1112380ms 07:26:29 INFO - TEST-START | kraken 07:26:29 INFO - operating with platform_type : linux_ 07:26:29 INFO - Initialising browser for kraken test... 07:26:29 INFO - TEST-INFO | started process 25735 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps8RdZQ/profile http://localhost:46716/getInfo.html) 07:26:33 INFO - PROCESS | 25735 | __metrics Screen width/height:1600/1200 07:26:33 INFO - PROCESS | 25735 | colorDepth:24 07:26:33 INFO - PROCESS | 25735 | Browser inner width/height: 1024/697 07:26:33 INFO - PROCESS | 25735 | __metrics 07:26:33 INFO - PROCESS | 25735 | 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:26:33 INFO - PROCESS | 25735 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:34 INFO - TEST-INFO | 25735: exit 0 07:26:34 INFO - Browser initialized. 07:26:34 INFO - Running cycle 1/1 for kraken test... 07:26:34 INFO - TEST-INFO | started process 25818 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps8RdZQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:46 INFO - PROCESS | 25818 | RSS: Main: 150319104 07:26:46 INFO - PROCESS | 25818 | 07:26:48 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46716/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:49 INFO - PROCESS | 25818 | RSS: Main: 187555840 07:26:49 INFO - PROCESS | 25818 | 07:26:52 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46716/tests/kraken/driver.html?testName=audio-dft) 07:26:52 INFO - PROCESS | 25818 | RSS: Main: 176910336 07:26:52 INFO - PROCESS | 25818 | 07:26:55 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46716/tests/kraken/driver.html?testName=audio-fft) 07:26:56 INFO - PROCESS | 25818 | RSS: Main: 161157120 07:26:56 INFO - PROCESS | 25818 | 07:26:58 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46716/tests/kraken/driver.html?testName=audio-oscillator) 07:26:58 INFO - PROCESS | 25818 | RSS: Main: 163934208 07:26:58 INFO - PROCESS | 25818 | 07:27:00 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46716/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:27:01 INFO - PROCESS | 25818 | RSS: Main: 165560320 07:27:01 INFO - PROCESS | 25818 | 07:27:04 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46716/tests/kraken/driver.html?testName=imaging-darkroom) 07:27:04 INFO - PROCESS | 25818 | RSS: Main: 165990400 07:27:04 INFO - PROCESS | 25818 | 07:27:08 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46716/tests/kraken/driver.html?testName=imaging-desaturate) 07:27:08 INFO - PROCESS | 25818 | RSS: Main: 166121472 07:27:08 INFO - PROCESS | 25818 | 07:27:11 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46716/tests/kraken/driver.html?testName=json-parse-financial) 07:27:12 INFO - PROCESS | 25818 | RSS: Main: 168312832 07:27:12 INFO - PROCESS | 25818 | 07:27:13 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46716/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:14 INFO - PROCESS | 25818 | RSS: Main: 178864128 07:27:14 INFO - PROCESS | 25818 | 07:27:16 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:16 INFO - PROCESS | 25818 | RSS: Main: 174850048 07:27:16 INFO - PROCESS | 25818 | 07:27:18 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:19 INFO - PROCESS | 25818 | RSS: Main: 183721984 07:27:19 INFO - PROCESS | 25818 | 07:27:21 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:22 INFO - PROCESS | 25818 | RSS: Main: 190504960 07:27:22 INFO - PROCESS | 25818 | 07:27:24 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:25 INFO - PROCESS | 25818 | RSS: Main: 190005248 07:27:25 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | Cycle 1(1): loaded http://localhost:46716/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46716/tests/kraken/driver.html?testName=ai-astar) 07:27:27 INFO - PROCESS | 25818 | RSS: Main: 247619584 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | __start_tp_report 07:27:27 INFO - PROCESS | 25818 | _x_x_mozilla_page_load 07:27:27 INFO - PROCESS | 25818 | _x_x_mozilla_page_load_details 07:27:27 INFO - PROCESS | 25818 | |i|pagename|runs| 07:27:27 INFO - PROCESS | 25818 | |0;ai-astar;110;112;104;112;112;110;101;111;110;111 07:27:27 INFO - PROCESS | 25818 | |1;audio-beat-detection;150;125;150;169;125;155;160;123;168;125 07:27:27 INFO - PROCESS | 25818 | |2;audio-dft;160;160;161;159;161;162;159;163;161;161 07:27:27 INFO - PROCESS | 25818 | |3;audio-fft;72;71;97;90;72;73;71;132;92;74 07:27:27 INFO - PROCESS | 25818 | |4;audio-oscillator;95;95;142;95;96;96;141;95;96;138 07:27:27 INFO - PROCESS | 25818 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 07:27:27 INFO - PROCESS | 25818 | |6;imaging-darkroom;146;145;145;146;145;145;147;145;145;145 07:27:27 INFO - PROCESS | 25818 | |7;imaging-desaturate;96;95;95;96;95;96;96;95;96;96 07:27:27 INFO - PROCESS | 25818 | |8;json-parse-financial;57;57;56;57;56;56;57;64;53;54 07:27:27 INFO - PROCESS | 25818 | |9;json-stringify-tinderbox;67;67;67;67;67;69;68;68;68;68 07:27:27 INFO - PROCESS | 25818 | |10;stanford-crypto-aes;81;81;82;83;84;84;82;82;82;81 07:27:27 INFO - PROCESS | 25818 | |11;stanford-crypto-ccm;117;113;131;115;125;115;118;119;115;116 07:27:27 INFO - PROCESS | 25818 | |12;stanford-crypto-pbkdf2;150;133;144;142;143;130;149;144;147;141 07:27:27 INFO - PROCESS | 25818 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;65;65;69;68;69 07:27:27 INFO - PROCESS | 25818 | __end_tp_report 07:27:27 INFO - PROCESS | 25818 | __start_cc_report 07:27:27 INFO - PROCESS | 25818 | _x_x_mozilla_cycle_collect,948 07:27:27 INFO - PROCESS | 25818 | __end_cc_report 07:27:27 INFO - PROCESS | 25818 | __startTimestamp1452698847251__endTimestamp 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | ------- Summary: start ------- 07:27:27 INFO - PROCESS | 25818 | Number of tests: 14 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.74 (3.4%) stddev-sans-first:3.96 07:27:27 INFO - PROCESS | 25818 | Values: 110.0 112.0 104.0 112.0 112.0 110.0 101.0 111.0 110.0 111.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:152.50 stddev:18.75 (12.3%) stddev-sans-first:19.80 07:27:27 INFO - PROCESS | 25818 | Values: 150.0 125.0 150.0 169.0 125.0 155.0 160.0 123.0 168.0 125.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 07:27:27 INFO - PROCESS | 25818 | Values: 160.0 160.0 161.0 159.0 161.0 162.0 159.0 163.0 161.0 161.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#3] audio-fft Cycles:10 Average:84.40 Median:73.50 stddev:19.49 (26.5%) stddev-sans-first:20.15 07:27:27 INFO - PROCESS | 25818 | Values: 72.0 71.0 97.0 90.0 72.0 73.0 71.0 132.0 92.0 74.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:21.72 (22.9%) stddev-sans-first:22.44 07:27:27 INFO - PROCESS | 25818 | Values: 95.0 95.0 142.0 95.0 96.0 96.0 141.0 95.0 96.0 138.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:27:27 INFO - PROCESS | 25818 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:27:27 INFO - PROCESS | 25818 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 147.0 145.0 145.0 145.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:27:27 INFO - PROCESS | 25818 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:3.08 07:27:27 INFO - PROCESS | 25818 | Values: 57.0 57.0 56.0 57.0 56.0 56.0 57.0 64.0 53.0 54.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 07:27:27 INFO - PROCESS | 25818 | Values: 67.0 67.0 67.0 67.0 67.0 69.0 68.0 68.0 68.0 68.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 07:27:27 INFO - PROCESS | 25818 | Values: 81.0 81.0 82.0 83.0 84.0 84.0 82.0 82.0 82.0 81.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:117.50 stddev:5.52 (4.7%) stddev-sans-first:5.83 07:27:27 INFO - PROCESS | 25818 | Values: 117.0 113.0 131.0 115.0 125.0 115.0 118.0 119.0 115.0 116.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:144.00 stddev:6.43 (4.5%) stddev-sans-first:6.19 07:27:27 INFO - PROCESS | 25818 | Values: 150.0 133.0 144.0 142.0 143.0 130.0 149.0 144.0 147.0 141.0 07:27:27 INFO - PROCESS | 25818 | 07:27:27 INFO - PROCESS | 25818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.40 (2.1%) stddev-sans-first:1.48 07:27:27 INFO - PROCESS | 25818 | Values: 67.0 68.0 67.0 67.0 67.0 65.0 65.0 69.0 68.0 69.0 07:27:27 INFO - PROCESS | 25818 | -------- Summary: end -------- 07:27:27 INFO - PROCESS | 25818 | 07:27:28 INFO - TEST-INFO | 25818: exit 0 07:27:28 INFO - TEST-OK | kraken | took 58493ms 07:27:28 INFO - TEST-START | v8_7 07:27:28 INFO - operating with platform_type : linux_ 07:27:28 INFO - Initialising browser for v8_7 test... 07:27:28 INFO - TEST-INFO | started process 26068 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx5tJJ1/profile http://localhost:46716/getInfo.html) 07:27:32 INFO - PROCESS | 26068 | __metrics Screen width/height:1600/1200 07:27:32 INFO - PROCESS | 26068 | colorDepth:24 07:27:32 INFO - PROCESS | 26068 | Browser inner width/height: 1024/697 07:27:32 INFO - PROCESS | 26068 | __metrics 07:27:32 INFO - PROCESS | 26068 | 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:27:32 INFO - PROCESS | 26068 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:27:33 INFO - TEST-INFO | 26068: exit 0 07:27:33 INFO - Browser initialized. 07:27:33 INFO - Running cycle 1/1 for v8_7 test... 07:27:33 INFO - TEST-INFO | started process 26150 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpx5tJJ1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:44 INFO - PROCESS | 26150 | RSS: Main: 150573056 07:27:44 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | Cycle 1(1): loaded http://localhost:46716/tests/v8_7/run.html (next: http://localhost:46716/tests/v8_7/run.html) 07:28:07 INFO - PROCESS | 26150 | RSS: Main: 550797312 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | __start_tp_report 07:28:07 INFO - PROCESS | 26150 | _x_x_mozilla_page_load 07:28:07 INFO - PROCESS | 26150 | _x_x_mozilla_page_load_details 07:28:07 INFO - PROCESS | 26150 | |i|pagename|runs| 07:28:07 INFO - PROCESS | 26150 | |0;Richards;167.7289500167729 07:28:07 INFO - PROCESS | 26150 | |1;DeltaBlue;188.00526414739613 07:28:07 INFO - PROCESS | 26150 | |2;Encrypt;279.87685418415896 07:28:07 INFO - PROCESS | 26150 | |3;Decrypt;5251.308900523561 07:28:07 INFO - PROCESS | 26150 | |4;RayTrace;1949.317738791423 07:28:07 INFO - PROCESS | 26150 | |5;Earley;766.4624808575804 07:28:07 INFO - PROCESS | 26150 | |6;Boyer;12317.073170731708 07:28:07 INFO - PROCESS | 26150 | |7;RegExp;41428.57142857143 07:28:07 INFO - PROCESS | 26150 | |8;Splay;580.046403712297 07:28:07 INFO - PROCESS | 26150 | |9;NavierStokes;4826.923076923077 07:28:07 INFO - PROCESS | 26150 | __end_tp_report 07:28:07 INFO - PROCESS | 26150 | __startTimestamp1452698887662__endTimestamp 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | ------- Summary: start ------- 07:28:07 INFO - PROCESS | 26150 | Number of tests: 10 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#0] Richards Cycles:1 Average:167.73 Median:167.73 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 167.7 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#1] DeltaBlue Cycles:1 Average:188.01 Median:188.01 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 188.0 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 279.9 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 5251.3 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#4] RayTrace Cycles:1 Average:1949.32 Median:1949.32 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 1949.3 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#5] Earley Cycles:1 Average:766.46 Median:766.46 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 766.5 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#6] Boyer Cycles:1 Average:12317.07 Median:12317.07 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 12317.1 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#7] RegExp Cycles:1 Average:41428.57 Median:41428.57 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 41428.6 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#8] Splay Cycles:1 Average:580.05 Median:580.05 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 580.0 07:28:07 INFO - PROCESS | 26150 | 07:28:07 INFO - PROCESS | 26150 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:28:07 INFO - PROCESS | 26150 | Values: 4826.9 07:28:07 INFO - PROCESS | 26150 | -------- Summary: end -------- 07:28:07 INFO - PROCESS | 26150 | 07:28:08 INFO - TEST-INFO | 26150: exit 0 07:28:08 INFO - TEST-OK | v8_7 | took 40335ms 07:28:08 INFO - SUITE-END | took 1211s 07:28:08 INFO - Completed test suite (00:20:11) 07:28:08 INFO - Working with test: dromaeo_css 07:28:08 INFO - Generating results file: dromaeo_css 07:28:08 INFO - Working with test: kraken 07:28:08 INFO - Generating results file: kraken 07:28:08 INFO - javascript benchmark 07:28:08 INFO - Working with test: v8_7 07:28:08 INFO - Generating results file: v8_7 07:28:08 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:28:08 INFO - process_Request line: dromaeo_css 6676.60 graph.html#tests=[[72,1,35]] 07:28:08 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:08 INFO - process_Request line: kraken 1492.80 graph.html#tests=[[232,1,35]] 07:28:08 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:28:08 INFO - process_Request line: v8_7 19076.14 graph.html#tests=[[230,1,35]] 07:28:08 INFO - RETURN: dromaeo_css: 6676.60 07:28:08 INFO - RETURN: kraken: 1492.80 07:28:08 INFO - RETURN: v8_7: 19076.14 07:28:08 INFO - javascript benchmark 07:28:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3126.9374612507763, 3128.9687103128967, 3170.1916011417084, 3173.412918610057, 3211.405889910366, 5019.54824065834, 5061.772220250088, 5072.974635126824, 5095.235714642806, 5125.666831655944, 5142.408623008355, 5163.509466600667, 5183.6371453998145, 5192.688438693681, 5226.372835259775, 4675.50907154749, 4676.36869022681, 4689.038747056845, 4753.453352864413, 4779.28310753388, 4817.940053188293, 4825.90348193036, 4838.782254798525, 4850.660453768238, 4874.488178741217, 4582.839600613979, 4663.556962088614, 4664.277037059262, 4694.507076756926, 4712.363830882856, 4673.439187297512, 4673.906521869543, 4678.578927896506, 4693.624510039189, 4718.056388722235, 4545.818167273305, 4708.693934894221, 4721.5750582447745, 4740.5733483986605, 4748.691335063209, 4931.334269873593, 5104.872378190538, 5148.845534633967, 5171.095058364771, 5185.325907632021, 5587.497125258706, 5591.329040515124, 5594.160875868612, 5619.578531610146, 5620.0, 5606.747696353674, 5622.269105016363, 5626.634268772516, 5637.548996080303, 5638.774449022034, 5044.596432285409, 5116.488351164891, 5118.923216151761, 5191.558717509016, 5264.0, 5690.2887139107615, 5708.31500219968, 5710.5717071219, 5720.599558030981, 5766.481016708516, 5489.780408783604, 5499.7250137492965, 5514.117741161475, 5517.806876759294, 5521.475459831309, 5347.010803001457, 5381.4349493303425, 5486.862828429321, 5529.917051244234, 5596.048671725816, 5466.398696143421, 5494.945050549523, 5501.724913754297, 5505.03661859173, 5516.972415137899, 5343.251944727741, 5505.339359276913, 5505.807296744595, 5509.173623956359, 5553.555715542747, 4246.917036155823, 4252.914941701149, 4266.957330426718, 4304.440422745023, 4305.225059489259, 3834.578196398394, 3858.7298889078056, 3866.845326186977, 3898.5126859142606, 3902.31709450845, 4961.330220420269, 5108.948910510921, 5118.923216151761, 5127.410347809975, 5165.251038599382, 5386.811461598825, 5388.811391601275, 5398.8920221595345, 5427.9185812212845, 5458.1266997280245, 5135.4094279157625, 5153.994970980698, 5158.613104017214, 5164.845054648366, 5201.843944681666, 4643.6517261205545, 4746.572808447257, 4759.6668233223345, 4765.809367625326, 4766.118268120409, 5515.227868098469, 5727.140928860705, 5778.075507918713, 5787.855303617359, 5837.270341207349, 5556.888862222814, 5585.972070139624, 5588.133839254922, 5588.916166257591, 5589.245451863946, 5564.805231816867, 5636.070048441961, 5710.5146062585145, 5788.7395067222915, 5796.449337312949, 5418.972905135449, 5438.483344082306, 5439.211314359475, 5443.8094666686475, 5486.945130548803, 5433.809816656398, 5439.972800135974, 5441.918371224356, 5445.074337362578, 5445.727713614224, 5143.8456846294675, 5233.842984710464, 5314.256004159498, 5328.227407026037, 5390.299261096033, 5469.72651367438, 5479.835604931858, 5485.917711234414, 5493.587980901369, 5494.5054945055135, 5287.154055351125, 5341.092014357646, 5359.544438722596, 5362.65142765719, 5434.0, 5301.019311427244, 5318.787248510016, 5375.086235339923, 5386.111291636836, 5487.368952570506, 5320.920186197288, 5324.387695415076, 5326.467353264643, 5331.040412725747, 5331.546818520314], "unit": "score", "name": "dojo.html", "value": 5100.518737693803}, {"lowerIsBetter": false, "replicates": [534.7887584404162, 540.8215288954644, 559.5299948043647, 562.2409746841764, 575.9287724831814, 28139.155825325248, 28588.14235572931, 28605.570916436245, 28614.0, 28665.713342866566, 36174.0, 36933.445998310046, 37102.814485927534, 37133.44299835504, 37141.814290928574, 8587.699430519933, 8743.868841967376, 8762.86855697165, 8765.254953328975, 8768.0, 8385.664573417056, 8488.405811593191, 8490.278326342268, 8507.234348908598, 8512.404131710782, 8322.085920238349, 8367.665293388258, 8368.832623347529, 8576.228139467446, 8599.699010534632, 8680.392372533894, 8735.432196907244, 8739.737807865775, 8742.038375778659, 8744.213020828125, 8620.78448038804, 8758.080401557809, 8763.211310981978, 8768.43005204666, 8777.824443511157, 39579.20841583181, 39894.80052599718, 40047.59952400497, 40067.0, 40108.79945600253, 3169.31859650174, 3305.3653678575874, 3358.882439114619, 3394.2193295541915, 3834.827432765532, 27319.0, 27389.726102739118, 27631.723682763117, 28381.71618283832, 28393.858030709922, 3654.196076863086, 3721.702263818888, 3862.903427414309, 3877.7673339599714, 3970.086880017583, 194667.99999999857, 194926.0, 195294.0, 196243.0, 196262.0, 53157.2026419604, 60401.39598604046, 60860.69569652124, 60880.391196087476, 60908.69545652332, 47449.5255047452, 60443.69778151169, 61720.69139654273, 61727.38272617216, 61732.38267617356, 14229.573112806633, 14446.0, 14542.200178990257, 14570.05294655844, 14587.41650333996, 9318.580663870142, 9406.764830879147, 10817.350958942488, 10847.67456976292, 10862.674119776419, 19475.083686287613, 20176.09207585662, 20304.28934987298, 20329.18683252683, 20347.08438120288, 7886.723964661324, 7909.604519773989, 8034.38452696289, 8067.556284404414, 8095.433319667567, 995.9402435853872, 1002.6240159940022, 1022.9130523905551, 1024.2881197567767, 1059.86751656043, 27456.45087098247, 28289.71710282871, 31133.0, 32834.671653283636, 33172.66827331744, 986.1469828598355, 1000.3897622450299, 1005.9195264378832, 1066.4188017530464, 1077.4289626497969, 14988.0, 15003.849961500464, 15047.623809404853, 15166.24168791556, 15179.696406072038, 379624.0, 382424.0, 383956.0, 384069.0, 384814.0, 54194.72902635462, 54705.45294547083, 54747.45252547503, 54791.45208547863, 54859.0, 1340.9329533523285, 1355.4984655677265, 1367.1387026173447, 1390.8052872597843, 1391.7842734376188, 27624.447511049264, 28372.290692732022, 28722.0, 28741.137765867057, 28763.712362876104, 46482.53517464782, 46704.065918682114, 46866.53133468758, 46912.53087469218, 46928.061438771714, 284661.0, 286884.0, 287019.0, 287427.0, 287676.0, 27403.17790466289, 30948.381032379675, 32240.83879580587, 32424.675753243107, 32502.674973249967, 36920.70777522774, 37402.41871965458, 37935.43096853494, 37938.0, 38128.428073579475, 31635.36729265448, 32147.517787232744, 32420.513692294164, 32856.01431957045, 33048.50427243545, 32780.50829237611, 33082.0, 33256.1685957853, 33469.66530334763, 35328.29343413169, 33732.3253534923, 33974.0, 33989.49015764815, 34022.0, 34534.30931381408, 29643.703562964096, 31226.843865780527, 31415.371692565564, 31695.0, 31711.36577268488, 23608.29175124749, 23666.88166559225, 23785.405364866016, 23929.162479313836, 24158.51682966366], "unit": "score", "name": "ext.html", "value": 17837.838967055577}, {"lowerIsBetter": false, "replicates": [352.5962772625344, 354.30202501072876, 358.73724489795933, 361.6148801526374, 363.32240371706774, 13321.733565328688, 13802.102863313878, 15622.531324060283, 15981.440649577253, 17070.2318395672, 15406.0, 15575.454859079906, 16602.0, 16726.24731887065, 16758.664826703458, 4980.875478113049, 5388.43421440749, 5390.1375779875225, 5403.567714582844, 5407.702576358299, 3973.9205215895663, 4122.546519882811, 5264.657797243186, 5754.65472071675, 5972.73122709477, 5479.397266300703, 5895.705214739246, 5914.0, 5935.792247271324, 5937.317208521011, 5379.112446446332, 5600.971995140018, 5626.212330273765, 5641.746121424546, 5642.689652069134, 5253.185756207794, 5278.419373868871, 5279.1817268323475, 5287.233351164098, 5293.020791153611, 12221.144519883612, 12414.379281035912, 12645.620631381073, 12691.682707932376, 12698.365081745967, 1960.304092047317, 2018.6467368210504, 2038.6941958706163, 2045.427280361501, 2164.296058243567, 9209.631614735403, 9410.200132988704, 9482.762930926712, 11631.47658355376, 12146.271223726604, 1816.927322907082, 1819.4450692538771, 1897.3169658922777, 1922.3656193456127, 2009.8090681385245, 46866.06267874623, 48895.511044889805, 48977.26534101991, 49054.26418603724, 49109.50890491085, 9403.90596094044, 9573.760655983517, 9575.856362154573, 9595.616175353047, 9642.566084526214, 12650.114491985472, 12667.429965651569, 12680.873191267969, 12705.682357940941, 12740.490380384867, 6691.297413771581, 6741.0, 6776.93223067763, 6799.660016999229, 6977.616231107237, 6302.590331628429, 6326.715297811609, 6527.510436717265, 6596.571222870498, 6598.307177746267, 3919.2161567686576, 4218.978905105516, 4220.6412454941055, 4235.708109026777, 4243.384709217146, 1675.899446033242, 1697.516207880748, 1764.6911790436623, 1783.8840475369059, 1803.4769916724003, 814.2918143811921, 858.9098144694717, 883.5140672630027, 884.4207044385809, 886.4326830828275, 13170.47318107284, 14881.0, 15653.921730391276, 16078.919605401898, 16506.504804855875, 795.2326005404813, 859.7979474823411, 904.7873749668822, 951.2342564235719, 971.1939090554822, 5643.506522683335, 5886.735096920564, 5979.222701048836, 7261.41908647307, 9202.677906273248, 440203.0, 497641.0, 497880.0, 543970.0, 549864.0, 72577.6371118141, 73054.0, 75632.24367756362, 76107.0, 76426.23573764303, 508.8829569199105, 517.6945602094706, 521.4759167037104, 523.3092318140094, 523.3876364653364, 9938.602455901682, 10434.0, 10506.947465262625, 10512.894871051498, 10513.89486105129, 30778.0, 32873.0, 33305.0, 33358.16604584905, 33528.832355838065, 45674.62976110722, 45686.08627827491, 47208.76395618, 48526.272105917735, 48928.75535622299, 9206.723798286062, 9914.801703966024, 9947.204223662235, 10286.794264114526, 10302.896971030194, 11605.883941160819, 11753.941230293794, 11816.0, 11884.168108232341, 12167.2699638022, 9443.386179898285, 9823.607055717977, 9962.800743984935, 9985.900140998498, 10080.193584513368, 10288.742781430525, 10447.94776026115, 10709.250352475252, 10841.891581084088, 10846.240763146505, 7146.100380706078, 9094.954525227331, 9316.673916412892, 9774.609015639579, 9802.068803463944, 9555.569999350186, 9922.900770992197, 10038.849417258893, 10155.086042256233, 10182.847257291294, 6878.071460352789, 9631.036896310314, 10031.498425078862, 10212.285140040125, 10213.642522511676], "unit": "score", "name": "jquery.html", "value": 7746.444886302482}, {"lowerIsBetter": false, "replicates": [1278.303324688045, 1374.780035194369, 1383.88236999855, 1506.1866592040299, 1774.0420173106522, 6633.1376921000265, 7720.150783413827, 7877.921220787791, 7886.408519361056, 7886.960565197166, 7650.770476885702, 7806.960965195166, 7823.374130069595, 7827.843443131134, 7841.960790196055, 1930.0735646889432, 1981.7522809648794, 2261.7851304126084, 2333.404981729661, 2358.469344397514, 2313.375388645065, 2322.6516022596575, 2336.789688927996, 2339.6958395408574, 2341.812654987597, 2175.1082056356895, 2252.7296724393095, 2257.24382331919, 2258.9096436142618, 2260.028187879211, 2295.7130358705163, 2314.456102815837, 2333.323336232499, 2347.9530409391887, 2348.5537747827857, 2292.5414917016665, 2301.4131396493954, 2323.6398358254496, 2327.6624889391114, 2330.370799884022, 7697.692092316301, 7754.302112809874, 7765.184655611192, 7767.223277672244, 7793.1817159198035, 4794.736289504076, 4895.510448955076, 4929.334539837112, 4948.0846043481715, 4950.603951683856, 2989.289046091517, 3011.578379026938, 3064.647565529948, 3068.202267410467, 3074.923126921845, 916.702071826659, 929.9581518831601, 938.2259635800424, 942.7878727286375, 967.908048735369, 10895.509702063426, 10899.618513351994, 10911.399873006982, 10924.617638382619, 10958.01377875987, 4316.611504964569, 4371.213181627274, 4387.670924680598, 4424.159409712144, 4430.468343798765, 8957.731268061969, 8959.641614335354, 8964.506952117566, 8965.193132618097, 8967.551622418852, 4877.341558889504, 4913.828016019422, 4925.630577706686, 4927.7536123193695, 4939.185034469272, 4414.1171765647, 4429.82280708768, 4432.0, 4432.29083346663, 4464.888377790517, 3370.612379576331, 3435.278591495814, 3435.4331535296897, 3435.4675025371107, 3645.7265705072227, 1214.4595654933646, 1221.2001139253803, 1223.663492539541, 1236.8763123687559, 1237.8514578250488, 1309.2798960571647, 1309.7118633900718, 1325.6420766393019, 1340.0753480098701, 1357.9932100339436, 7293.380062694624, 7350.117985841734, 7502.62486875654, 7503.399728021745, 7513.098428188652, 1104.4091411095026, 1117.8435019097333, 1118.692359601116, 1125.9732085776013, 1139.9145064120057, 5853.326867410217, 5879.265091863517, 5937.317208520989, 5942.61373010753, 5946.643201407929, 9068.138526839939, 9275.0, 9301.069893010645, 9426.62293508252, 9459.290553208537, 9240.95379523098, 9363.063693630582, 9370.62517499306, 9373.015833337538, 9384.390014649027, 7261.564306141649, 7309.378702810321, 7351.558906465629, 7414.777556673308, 7433.442491813135, 7360.33756961876, 7430.851382972202, 7476.177620461636, 7478.588677622783, 7481.700731970878, 8178.223068808454, 8368.497890126611, 8431.19903609156, 8602.82794344097, 8605.182507661762, 8390.202930721573, 8533.74398768038, 8693.782655433664, 8694.956525217334, 8711.56442177876, 6992.1259842519685, 7066.152061752623, 7077.469189810682, 7098.006279120824, 7102.786916392516, 6373.426391624776, 6546.738130474918, 6552.705128269335, 6558.409743123142, 7392.37164840973, 6383.297837237993, 6428.935710642833, 6869.862602748017, 6889.621070841152, 7007.7196912122945, 6553.836154096186, 6575.539712220098, 6595.703193356215, 6687.130673012672, 6880.208775990825, 6954.582725036514, 7009.228984811564, 7022.719091236293, 7024.086868707035, 7024.894626580503, 6430.0, 6585.176852893388, 6610.4050635443045, 6622.470202383702, 6630.038644396632, 6645.069690243273, 6679.031540426514, 6680.63256520896, 6681.699323530355, 6683.7660681875905], "unit": "score", "name": "mootools.html", "value": 4503.690606324527}, {"lowerIsBetter": false, "replicates": [329.99340013199736, 330.87426777824425, 334.37138180221183, 340.86024729860753, 341.52186938286394, 5650.434956504358, 5820.708964551766, 5822.621529600573, 5859.501942334901, 5860.765569377219, 5620.437956204378, 5758.193852860592, 5759.049756790125, 5770.884582308351, 5771.394003629622, 4457.554244575549, 4483.574060464267, 4508.864734057967, 4514.210013247685, 4528.18492671319, 4338.370936214247, 4412.47050353958, 4442.955570444303, 4521.163584736834, 4526.0, 4490.7081039732475, 4492.168948744493, 4506.076254367863, 4512.1426928883575, 4512.2329204035395, 4462.910741785162, 4494.1910456117885, 4502.347159661831, 4506.3465797459185, 4507.5267096955, 3951.0, 3973.304671682473, 3974.920501589981, 3981.442598036277, 3984.203159368138, 5438.157085651691, 5583.972080139614, 5612.719364031782, 5615.101583746581, 5621.690807005613, 5118.795248190068, 5151.253068305112, 5152.355955505562, 5160.716160611165, 5163.380394352665, 5821.50517206038, 6137.079438084323, 6139.693015349215, 6147.661878596676, 6148.7233074511305, 4146.813393397304, 4170.291050521389, 4236.301010333292, 4246.299360605496, 4252.957470425287, 6302.086197501382, 6394.552381333308, 6398.648074355862, 6398.9040164397575, 6401.967990160019, 4317.956820431756, 4318.568143185719, 4320.481542214954, 4320.611144996966, 4323.805428755713, 4236.597523235288, 4368.759718215465, 4375.824967001348, 4377.627901628333, 4381.912361752811, 5056.469070747518, 5062.0, 5065.265536497187, 5068.594512438996, 5072.087024335655, 6189.721462534197, 6190.721417536131, 6194.938050619527, 6197.318294987548, 6198.380161983766, 1549.7830303757257, 1581.122477025239, 1581.343742346936, 1581.5808810665183, 1582.1298285942685, 1040.1366865501616, 1044.6187141693226, 1046.2937517175876, 1046.5186014433293, 1072.7425417899804, 5778.930897783924, 5794.101914203306, 5802.506786923074, 5813.7383817728305, 5822.184894114827, 6362.491000719931, 6363.395477429637, 6376.968115159488, 6381.329960354189, 6385.233771947396, 5821.941780582225, 5825.271841019872, 5827.854303642443, 5828.504577110908, 5828.708564571754, 3338.716209122203, 3440.0539851540525, 3443.6384179661277, 3448.9655103449145, 3449.344624521333, 6573.901391479131, 6638.800835974928, 6638.933610663831, 6646.900296495556, 6650.667466626649, 6482.57863238888, 6484.740610375627, 6488.0, 6491.837704057436, 6500.4799616030605, 6507.157181384387, 6564.113844631009, 6597.0, 6614.503912206507, 6617.867642647217, 6213.068039794067, 6311.053341998737, 6339.683015849281, 6345.302016778059, 6350.809475715736, 6146.170267014075, 6299.6535190564955, 6315.368463153648, 6324.905126423016, 6366.427021568081, 6653.933460665525, 6654.600723956578, 6659.700313485808, 6675.7997260082275, 6697.3637504437, 4245.639120674654, 4451.020775429401, 4451.1765323415275, 4455.2426087564545, 4457.064016556559, 6354.714037868214, 6357.491400687842, 6358.109864619049, 6366.6180029198395, 6370.885095108245, 6194.783182588588, 6200.627962322275, 6213.099100630474, 6215.81352559424, 6216.720247588779, 6069.757209711562, 6217.96891015542, 6236.064590311489, 6260.7495700171485, 6266.279377871603, 6155.784547540815, 6157.476614487639, 6159.969200153971, 6162.075688646739, 6162.506999439945, 6302.401271879165, 6341.365863413806, 6358.459530939737, 6374.107624932606, 6377.298497165215, 6058.485028772604, 6091.5126789857595, 6145.8156255312415, 6147.139400483847, 6156.230471191101], "unit": "score", "name": "prototype.html", "value": 4662.9406968615}, {"lowerIsBetter": false, "replicates": [736.2858027713116, 783.4202690009392, 813.585071613477, 823.3824631526355, 831.6091437024596, 12717.17338373005, 12883.871161288384, 12892.742145157092, 12913.80629290559, 12955.80566291504, 12584.874151258484, 12653.114282000264, 12654.367281635927, 12660.62018139455, 12662.303573303465, 661.7452280871851, 674.0832467843728, 804.6258489802241, 821.4578378270343, 825.1047613339534, 821.8397412504564, 826.2316046077145, 828.958552072397, 829.5437509369852, 830.5058490198322, 853.6542700206427, 859.8925134358205, 860.9053004169537, 861.3023451004675, 863.115306810518, 684.7226873116371, 694.8610277944406, 847.5889193741, 859.9398042137053, 863.3611127765471, 630.6184758221302, 632.9620222786648, 633.1768700689086, 633.7148283272546, 633.787681126823, 11703.0, 11833.763324733543, 11857.288562686266, 11879.346635935106, 11880.702982425422, 12521.499140034388, 12950.417231224617, 12953.805692914613, 13211.339433028406, 13257.138286011475, 10167.237457190666, 10199.4390308533, 10480.580776768997, 10685.091767199798, 10821.567137314498, 3607.482848085885, 3624.1483251435893, 3631.1103779574173, 3668.4313931340416, 3771.113788259784, 45375.773121134516, 45594.54405455936, 45667.314990275176, 46231.76884115558, 46332.3050154248, 9713.989699245896, 9999.450030248407, 10022.899771002343, 10104.898951010542, 10175.440350780778, 17294.827051729575, 17495.737563936553, 17498.212580433657, 17503.47489575315, 17516.912415438095, 6811.523193376515, 6845.349691779273, 6975.6163411012885, 7037.120359955005, 7158.105236845395, 4333.068390296102, 4388.71473354231, 4394.648428125743, 4415.094905544356, 4427.845025424094, 3015.261260991071, 3047.9542806857917, 3058.204866734665, 3063.1423201503617, 3067.371188906269, 562.0922210629885, 564.9943500565024, 567.3617180671745, 576.1242910775597, 598.8023952095798, 493.88393727474016, 497.3608912547359, 506.5643546549964, 524.0828550037435, 606.5602438232246, 7554.848903022019, 7602.42981776369, 7770.805729856799, 8012.399070069768, 8109.59452027408, 587.6386022596158, 610.2737742086903, 681.0, 701.5019336271305, 716.6810769207757, 3302.570665813477, 3347.5132190990803, 3420.675035871588, 3497.3529896969144, 3550.2544465661986, 52302.47697523052, 52734.0, 52921.7353913228, 52927.47072529225, 53098.0, 45726.77136614296, 45759.08481830345, 45983.0, 46039.53960460419, 46382.30426543605, 43406.13187736228, 44000.3399949001, 44784.552154478035, 44819.0, 45093.323600146025, 7423.740169094056, 7600.771976840703, 7616.35261002821, 7621.466497345133, 7649.31156195945, 32448.0, 32497.837510812296, 33082.5037624431, 33201.66798331986, 33671.0, 40401.0, 40573.0, 43591.56408436002, 43688.56311436845, 43952.78023609862, 9514.286428517751, 9636.855447168158, 9895.723983483695, 9988.158111693514, 10002.599896004078, 11073.808887172441, 11131.72170695739, 11141.665750027512, 11449.42752862337, 11925.701857453632, 9969.252306076929, 10339.534720937425, 10479.790404192026, 10701.304415212986, 10950.616728414467, 11176.217664763388, 11373.54505819758, 11521.0, 11548.307101573933, 11861.703457413289, 9280.814383712423, 9626.892907315749, 10385.480725963822, 10404.947975260075, 10421.166306695597, 6182.629042257479, 8519.701810436605, 8621.784455388666, 8978.775530611787, 9168.541572921195, 8737.78155546091, 8810.471371717718, 8881.911180888366, 8973.641054357753, 9076.636934522545], "unit": "score", "name": "yui.html", "value": 5984.228672232409}], "name": "dromaeo_css", "value": 6676.602303759866}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 104.0, 112.0, 112.0, 110.0, 101.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 150.0, 169.0, 125.0, 155.0, 160.0, 123.0, 168.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 162.0, 159.0, 163.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 97.0, 90.0, 72.0, 73.0, 71.0, 132.0, 92.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 142.0, 95.0, 96.0, 96.0, 141.0, 95.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 147.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 64.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 83.0, 84.0, 84.0, 82.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [117.0, 113.0, 131.0, 115.0, 125.0, 115.0, 118.0, 119.0, 115.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [150.0, 133.0, 144.0, 142.0, 143.0, 130.0, 149.0, 144.0, 147.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 65.0, 65.0, 69.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1492.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.7289500167729], "unit": "score", "name": "Richards", "value": 210.47052400000004}, {"lowerIsBetter": false, "replicates": [188.00526414739613], "unit": "score", "name": "DeltaBlue", "value": 351.68164199999995}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1949.317738791423], "unit": "score", "name": "RayTrace", "value": 379.61435700000015}, {"lowerIsBetter": false, "replicates": [766.4624808575804], "unit": "score", "name": "Earley", "value": 869.5311468531465}, {"lowerIsBetter": false, "replicates": [12317.073170731708], "unit": "score", "name": "Boyer", "value": 54.108877227722786}, {"lowerIsBetter": false, "replicates": [41428.57142857143], "unit": "score", "name": "RegExp", "value": 21.989293103448276}, {"lowerIsBetter": false, "replicates": [580.046403712297], "unit": "score", "name": "Splay", "value": 140.490484}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19076.135370106396}]} 07:28:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19076.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1492.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6676.60"}}} 07:28:08 INFO - Return code: 0 07:28:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:28:08 INFO - # TBPL SUCCESS # 07:28:08 INFO - Running post-action listener: _resource_record_post_action 07:28:08 INFO - Running post-run listener: _resource_record_post_run 07:28:09 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 12288; Write bytes: 314097664; Read time: 184; Write time: 227080 07:28:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15650816; Read time: 0; Write time: 6080 07:28:10 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 12288; Write bytes: 298446848; Read time: 184; Write time: 221000 07:28:10 INFO - Running post-run listener: _upload_blobber_files 07:28:10 INFO - Blob upload gear active. 07:28:10 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:28:10 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:28:10 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:28:10 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:28:10 INFO - (blobuploader) - INFO - Open directory for files ... 07:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:11 INFO - (blobuploader) - INFO - Done attempting. 07:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:28:12 INFO - (blobuploader) - INFO - Done attempting. 07:28:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:28:12 INFO - Return code: 0 07:28:12 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:28:12 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:28:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ee74a764040c7602bdb8c799776303a031f21c5dc01aa331f811ca5c25624937441f5bc86c4661609913183fcab1f0a73dd569fd25e8cdf1e47c57aa29d4812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/021fd6457ba670b46c7d95a767704a4f0519947d3dd7a8d177edd266c884e759b416b96ca1750fbdfdd9e47bd0165100b60d03d8317550ddd70312fb0e30ff85"} 07:28:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:28:12 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:28:12 INFO - Contents: 07:28:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ee74a764040c7602bdb8c799776303a031f21c5dc01aa331f811ca5c25624937441f5bc86c4661609913183fcab1f0a73dd569fd25e8cdf1e47c57aa29d4812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/021fd6457ba670b46c7d95a767704a4f0519947d3dd7a8d177edd266c884e759b416b96ca1750fbdfdd9e47bd0165100b60d03d8317550ddd70312fb0e30ff85"} 07:28:12 INFO - Copying logs to upload dir... 07:28:12 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1640.469901 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 20 secs) (at 2016-01-13 07:28:11.624567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:28:11.627924) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 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/6ee74a764040c7602bdb8c799776303a031f21c5dc01aa331f811ca5c25624937441f5bc86c4661609913183fcab1f0a73dd569fd25e8cdf1e47c57aa29d4812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/021fd6457ba670b46c7d95a767704a4f0519947d3dd7a8d177edd266c884e759b416b96ca1750fbdfdd9e47bd0165100b60d03d8317550ddd70312fb0e30ff85"} build_url:https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/d-WV5bPoSy6BYjEB7uWLbw/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/6ee74a764040c7602bdb8c799776303a031f21c5dc01aa331f811ca5c25624937441f5bc86c4661609913183fcab1f0a73dd569fd25e8cdf1e47c57aa29d4812", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/021fd6457ba670b46c7d95a767704a4f0519947d3dd7a8d177edd266c884e759b416b96ca1750fbdfdd9e47bd0165100b60d03d8317550ddd70312fb0e30ff85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:28:11.652673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:28:11.652993) ========= 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=20e666a3d4cfbb71505a330e000001b4-1452688771.308459-1148553895 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:28:11.736903) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:28:11.737276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:28:11.737760) ========= ========= Total master_lag: 0.23 =========