builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-044 starttime: 1453615212.45 results: success (0) buildid: 20160123193118 builduid: 4b880af1b8884befa5f5e2b749af3623 revision: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.445672) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.446362) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.446682) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006422 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.479522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.479849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.514754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.515034) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.570137) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.570468) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.570831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.571134) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 22:00:13-- 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% 43.9M=0s 2016-01-23 22:00:13 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.404789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.990053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:12.990415) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.040365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.040767) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --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 d6d81655dd9e146c300a64c0fcaeb04ca3300a19 --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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 22:00:13,984 truncating revision to first 12 chars 2016-01-23 22:00:13,984 Setting DEBUG logging. 2016-01-23 22:00:13,984 attempt 1/10 2016-01-23 22:00:13,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d6d81655dd9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 22:00:14,251 unpacking tar archive at: mozilla-central-d6d81655dd9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550555 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.604552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.604970) ========= echo d6d81655dd9e146c300a64c0fcaeb04ca3300a19 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd6d81655dd9e146c300a64c0fcaeb04ca3300a19'] 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False d6d81655dd9e146c300a64c0fcaeb04ca3300a19 program finished with exit code 0 elapsedTime=0.003519 script_repo_revision: 'd6d81655dd9e146c300a64c0fcaeb04ca3300a19' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.653784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.654132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 22:00:13.664444) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 22:00:13.664774) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:14 INFO - MultiFileLogger online at 20160123 22:00:14 in /builds/slave/test-pgo 22:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:00:14 INFO - {'append_to_log': False, 22:00:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:00:14 INFO - 'blob_upload_branch': 'Firefox', 22:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:00:14 INFO - 'branch': 'Firefox', 22:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:14 INFO - 'config_files': ('talos/linux_config.py',), 22:00:14 INFO - 'default_actions': ('clobber', 22:00:14 INFO - 'read-buildbot-config', 22:00:14 INFO - 'download-and-extract', 22:00:14 INFO - 'populate-webroot', 22:00:14 INFO - 'create-virtualenv', 22:00:14 INFO - 'install', 22:00:14 INFO - 'run-tests'), 22:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:14 INFO - 'download_minidump_stackwalk': True, 22:00:14 INFO - 'download_symbols': 'ondemand', 22:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:14 INFO - 'installer_path': 'installer.exe', 22:00:14 INFO - 'log_level': 'info', 22:00:14 INFO - 'log_name': 'talos', 22:00:14 INFO - 'log_to_console': True, 22:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:14 INFO - 'opt_config_files': (), 22:00:14 INFO - 'pip_index': False, 22:00:14 INFO - 'sps_profile': False, 22:00:14 INFO - 'sps_profile_interval': 0, 22:00:14 INFO - 'suite': 'dromaeojs-e10s', 22:00:14 INFO - 'system_bits': '32', 22:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:14 INFO - 'title': 'talos-linux64-ix-044', 22:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:14 INFO - 'use_talos_json': True, 22:00:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:14 INFO - 'work_dir': 'build'} 22:00:14 INFO - ##### 22:00:14 INFO - ##### Running clobber step. 22:00:14 INFO - ##### 22:00:14 INFO - Running pre-action listener: _resource_record_pre_action 22:00:14 INFO - Running main action method: clobber 22:00:14 INFO - rmtree: /builds/slave/test-pgo/build 22:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:00:15 INFO - Running post-action listener: _resource_record_post_action 22:00:15 INFO - ##### 22:00:15 INFO - ##### Running read-buildbot-config step. 22:00:15 INFO - ##### 22:00:15 INFO - Running pre-action listener: _resource_record_pre_action 22:00:15 INFO - Running main action method: read_buildbot_config 22:00:15 INFO - Using buildbot properties: 22:00:15 INFO - { 22:00:15 INFO - "project": "", 22:00:15 INFO - "product": "firefox", 22:00:15 INFO - "script_repo_revision": "production", 22:00:15 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:00:15 INFO - "repository": "", 22:00:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:00:15 INFO - "buildid": "20160123193118", 22:00:15 INFO - "pgo_build": "True", 22:00:15 INFO - "basedir": "/builds/slave/test-pgo", 22:00:15 INFO - "buildnumber": 318, 22:00:15 INFO - "slavename": "talos-linux64-ix-044", 22:00:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:00:15 INFO - "platform": "ubuntu64_hw", 22:00:15 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:00:15 INFO - "branch": "mozilla-central", 22:00:15 INFO - "repo_path": "mozilla-central", 22:00:15 INFO - "revision": "d6d81655dd9e146c300a64c0fcaeb04ca3300a19", 22:00:15 INFO - "stage_platform": "linux64-pgo", 22:00:15 INFO - "builduid": "4b880af1b8884befa5f5e2b749af3623", 22:00:15 INFO - "slavebuilddir": "test" 22:00:15 INFO - } 22:00:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:00:15 INFO - Running post-action listener: _resource_record_post_action 22:00:15 INFO - ##### 22:00:15 INFO - ##### Running download-and-extract step. 22:00:15 INFO - ##### 22:00:15 INFO - Running pre-action listener: _resource_record_pre_action 22:00:15 INFO - Running main action method: download_and_extract 22:00:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:15 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json 22:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json 22:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:00:25 INFO - Downloaded 1448 bytes. 22:00:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:00:25 INFO - Using the following test package requirements: 22:00:25 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:25 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:25 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:25 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'jsshell-linux-x86_64.zip'], 22:00:25 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:25 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:25 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:25 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:25 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:25 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:25 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:25 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:25 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:25 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:34 INFO - Downloaded 22490362 bytes. 22:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:36 INFO - Return code: 0 22:00:36 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 22:00: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')]} 22:00:36 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:37 INFO - Downloaded 22490362 bytes. 22:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:38 INFO - Return code: 0 22:00: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')]} 22:00:38 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:39 INFO - Downloaded 10706572 bytes. 22:00:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:00:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:00:39 INFO - Return code: 0 22:00:39 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')]} 22:00:39 INFO - https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LINN7KdFRy-M4V9KBVYy7A/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 22:00:41 INFO - Downloaded 55968050 bytes. 22:00:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:41 INFO - mkdir: /builds/slave/test-pgo/properties 22:00:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:00:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:00:41 INFO - Contents: 22:00:41 INFO - build_url:https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:00:41 INFO - Running post-action listener: _resource_record_post_action 22:00:41 INFO - Running post-action listener: set_extra_try_arguments 22:00:41 INFO - ##### 22:00:41 INFO - ##### Running populate-webroot step. 22:00:41 INFO - ##### 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: populate_webroot 22:00:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:41 INFO - '--tppagecycles', 22:00:41 INFO - '7'], 22:00:41 INFO - 'tests': ['tsvgm']}}, 22:00:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:00:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:00:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'tests': ['damp', 'tps']}, 22:00:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['damp', 'tps']}, 22:00:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:00:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:41 INFO - 'other': {'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'other_l64': {'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'other_nol64': {'tests': ['a11yr', 22:00:41 INFO - 'ts_paint', 22:00:41 INFO - 'tpaint', 22:00:41 INFO - 'sessionrestore', 22:00:41 INFO - 'sessionrestore_no_auto_restore']}, 22:00:41 INFO - 'svgr': {'tests': ['tsvgx', 22:00:41 INFO - 'tsvgr_opacity', 22:00:41 INFO - 'tart', 22:00:41 INFO - 'tscrollx', 22:00:41 INFO - 'cart']}, 22:00:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['tsvgx', 22:00:41 INFO - 'tsvgr_opacity', 22:00:41 INFO - 'tart', 22:00:41 INFO - 'tscrollx', 22:00:41 INFO - 'cart']}, 22:00:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'tests': ['tp5o']}, 22:00:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'talos_options': ['--e10s'], 22:00:41 INFO - 'tests': ['tp5o']}, 22:00:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'talos_options': ['--xperf_path', 22:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:41 INFO - 'tests': ['tp5n']}, 22:00:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:41 INFO - 'talos_options': ['--e10s', 22:00:41 INFO - '--xperf_path', 22:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:41 INFO - 'tests': ['tp5n']}}, 22:00:41 INFO - 'talos.zip': {'path': '', 22:00:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:41 INFO - Running post-action listener: _resource_record_post_action 22:00:41 INFO - ##### 22:00:41 INFO - ##### Running create-virtualenv step. 22:00:41 INFO - ##### 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: create_virtualenv 22:00:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:00:41 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 22:00:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:00:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:41 INFO - Using real prefix '/usr' 22:00:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:00:41 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:43 INFO - Installing pip.................done. 22:00:43 INFO - Return code: 0 22:00:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:00:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:00:43 INFO - Using env: {'DISPLAY': ':0', 22:00:43 INFO - 'HOME': '/home/cltbld', 22:00:43 INFO - 'LANG': 'en_US.UTF-8', 22:00:43 INFO - 'LANGUAGE': 'en_US:en', 22:00:43 INFO - 'LOGNAME': 'cltbld', 22:00:43 INFO - 'MAIL': '/var/mail/cltbld', 22:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:43 INFO - 'MOZ_NO_REMOTE': '1', 22:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:43 INFO - 'NO_EM_RESTART': '1', 22:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:43 INFO - 'SHELL': '/bin/bash', 22:00:43 INFO - 'SHLVL': '1', 22:00:43 INFO - 'TERM': 'linux', 22:00:43 INFO - 'TMOUT': '86400', 22:00:43 INFO - 'USER': 'cltbld', 22:00:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:43 INFO - '_': '/tools/buildbot/bin/python'} 22:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:43 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 22:00:43 INFO - Cleaning up... 22:00:43 INFO - Return code: 0 22:00:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:00:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:00:43 INFO - Using env: {'DISPLAY': ':0', 22:00:43 INFO - 'HOME': '/home/cltbld', 22:00:43 INFO - 'LANG': 'en_US.UTF-8', 22:00:43 INFO - 'LANGUAGE': 'en_US:en', 22:00:43 INFO - 'LOGNAME': 'cltbld', 22:00:43 INFO - 'MAIL': '/var/mail/cltbld', 22:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:43 INFO - 'MOZ_NO_REMOTE': '1', 22:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:43 INFO - 'NO_EM_RESTART': '1', 22:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:43 INFO - 'SHELL': '/bin/bash', 22:00:43 INFO - 'SHLVL': '1', 22:00:43 INFO - 'TERM': 'linux', 22:00:43 INFO - 'TMOUT': '86400', 22:00:43 INFO - 'USER': 'cltbld', 22:00:43 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:43 INFO - '_': '/tools/buildbot/bin/python'} 22:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:44 INFO - Downloading/unpacking psutil>=0.7.1 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:44 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 22:00:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:46 INFO - Installing collected packages: psutil 22:00:46 INFO - Running setup.py install for psutil 22:00:46 INFO - building 'psutil._psutil_linux' extension 22:00:46 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 22:00:46 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 22:00:46 INFO - building 'psutil._psutil_posix' extension 22:00:46 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 22:00:46 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 22:00:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:46 INFO - Successfully installed psutil 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:00:46 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')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 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')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:00:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:00:46 INFO - Using env: {'DISPLAY': ':0', 22:00:46 INFO - 'HOME': '/home/cltbld', 22:00:46 INFO - 'LANG': 'en_US.UTF-8', 22:00:46 INFO - 'LANGUAGE': 'en_US:en', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MAIL': '/var/mail/cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SHLVL': '1', 22:00:46 INFO - 'TERM': 'linux', 22:00:46 INFO - 'TMOUT': '86400', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:00:48 INFO - Installing collected packages: mozsystemmonitor 22:00:48 INFO - Running setup.py install for mozsystemmonitor 22:00:48 INFO - Successfully installed mozsystemmonitor 22:00:48 INFO - Cleaning up... 22:00:48 INFO - Return code: 0 22:00:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:00:48 INFO - Using env: {'DISPLAY': ':0', 22:00:48 INFO - 'HOME': '/home/cltbld', 22:00:48 INFO - 'LANG': 'en_US.UTF-8', 22:00:48 INFO - 'LANGUAGE': 'en_US:en', 22:00:48 INFO - 'LOGNAME': 'cltbld', 22:00:48 INFO - 'MAIL': '/var/mail/cltbld', 22:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:48 INFO - 'MOZ_NO_REMOTE': '1', 22:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:48 INFO - 'NO_EM_RESTART': '1', 22:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:48 INFO - 'SHELL': '/bin/bash', 22:00:48 INFO - 'SHLVL': '1', 22:00:48 INFO - 'TERM': 'linux', 22:00:48 INFO - 'TMOUT': '86400', 22:00:48 INFO - 'USER': 'cltbld', 22:00:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:48 INFO - '_': '/tools/buildbot/bin/python'} 22:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:50 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 22:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:00:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:51 INFO - Downloading docopt-0.6.1.tar.gz 22:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:51 INFO - Running setup.py install for blobuploader 22:00:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:00:51 INFO - Running setup.py install for requests 22:00:51 INFO - Running setup.py install for docopt 22:00:51 INFO - Successfully installed blobuploader requests docopt 22:00:51 INFO - Cleaning up... 22:00:52 INFO - Return code: 0 22:00:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:52 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')]} 22:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:52 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')]} 22:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:52 INFO - Using env: {'DISPLAY': ':0', 22:00:52 INFO - 'HOME': '/home/cltbld', 22:00:52 INFO - 'LANG': 'en_US.UTF-8', 22:00:52 INFO - 'LANGUAGE': 'en_US:en', 22:00:52 INFO - 'LOGNAME': 'cltbld', 22:00:52 INFO - 'MAIL': '/var/mail/cltbld', 22:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:52 INFO - 'MOZ_NO_REMOTE': '1', 22:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:52 INFO - 'NO_EM_RESTART': '1', 22:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:52 INFO - 'SHELL': '/bin/bash', 22:00:52 INFO - 'SHLVL': '1', 22:00:52 INFO - 'TERM': 'linux', 22:00:52 INFO - 'TMOUT': '86400', 22:00:52 INFO - 'USER': 'cltbld', 22:00:52 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:52 INFO - '_': '/tools/buildbot/bin/python'} 22:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:52 INFO - Running setup.py (path:/tmp/pip-_kh4nT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:52 INFO - Running setup.py (path:/tmp/pip-J4DKms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:52 INFO - Running setup.py (path:/tmp/pip-E4IQPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:52 INFO - Running setup.py (path:/tmp/pip-3VGr8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:52 INFO - Running setup.py (path:/tmp/pip-0I9EzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:52 INFO - Running setup.py (path:/tmp/pip-fekE6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:52 INFO - Running setup.py (path:/tmp/pip-E9Rg9W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:52 INFO - Running setup.py (path:/tmp/pip-8f4ym9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:52 INFO - Running setup.py (path:/tmp/pip-tWh84V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:52 INFO - Running setup.py (path:/tmp/pip-YTkYB5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:52 INFO - Running setup.py (path:/tmp/pip-ff4nLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:53 INFO - Running setup.py (path:/tmp/pip-_9v2iW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:53 INFO - Running setup.py (path:/tmp/pip-6v7IUg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:53 INFO - Running setup.py (path:/tmp/pip-OL9uWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:53 INFO - Running setup.py (path:/tmp/pip-3Byc3h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:53 INFO - Running setup.py (path:/tmp/pip-JM9Ig8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:53 INFO - Running setup.py (path:/tmp/pip-udqqon-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:53 INFO - Running setup.py install for manifestparser 22:00:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:00:53 INFO - Running setup.py install for mozcrash 22:00:53 INFO - Running setup.py install for mozdebug 22:00:53 INFO - Running setup.py install for mozdevice 22:00:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:00:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:00:53 INFO - Running setup.py install for mozfile 22:00:54 INFO - Running setup.py install for mozhttpd 22:00:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozinfo 22:00:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozInstall 22:00:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozleak 22:00:54 INFO - Running setup.py install for mozlog 22:00:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for moznetwork 22:00:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozprocess 22:00:54 INFO - Running setup.py install for mozprofile 22:00:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozrunner 22:00:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:00:54 INFO - Running setup.py install for mozscreenshot 22:00:55 INFO - Running setup.py install for moztest 22:00:55 INFO - Running setup.py install for mozversion 22:00:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:00:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:55 INFO - Cleaning up... 22:00:55 INFO - Return code: 0 22:00:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:55 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')]} 22:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:55 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')]} 22:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:00:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:55 INFO - Using env: {'DISPLAY': ':0', 22:00:55 INFO - 'HOME': '/home/cltbld', 22:00:55 INFO - 'LANG': 'en_US.UTF-8', 22:00:55 INFO - 'LANGUAGE': 'en_US:en', 22:00:55 INFO - 'LOGNAME': 'cltbld', 22:00:55 INFO - 'MAIL': '/var/mail/cltbld', 22:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:55 INFO - 'MOZ_NO_REMOTE': '1', 22:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:55 INFO - 'NO_EM_RESTART': '1', 22:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:55 INFO - 'SHELL': '/bin/bash', 22:00:55 INFO - 'SHLVL': '1', 22:00:55 INFO - 'TERM': 'linux', 22:00:55 INFO - 'TMOUT': '86400', 22:00:55 INFO - 'USER': 'cltbld', 22:00:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:55 INFO - '_': '/tools/buildbot/bin/python'} 22:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:55 INFO - Running setup.py (path:/tmp/pip-i9H6M5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:55 INFO - Running setup.py (path:/tmp/pip-iUG6kA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:55 INFO - Running setup.py (path:/tmp/pip-l2fdse-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:55 INFO - Running setup.py (path:/tmp/pip-b2Gc5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:55 INFO - Running setup.py (path:/tmp/pip-NYEfO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:55 INFO - Running setup.py (path:/tmp/pip-DAYXww-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:55 INFO - Running setup.py (path:/tmp/pip-rV6ZTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:00:55 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)) 22:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:55 INFO - Running setup.py (path:/tmp/pip-8IAA3Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:56 INFO - Running setup.py (path:/tmp/pip-ofxQzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:56 INFO - Running setup.py (path:/tmp/pip-MPs2HN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:56 INFO - Running setup.py (path:/tmp/pip-OTp8Wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:56 INFO - Running setup.py (path:/tmp/pip-CPKSvL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:56 INFO - Running setup.py (path:/tmp/pip-WOflys-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:56 INFO - Running setup.py (path:/tmp/pip-ey2gSe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:56 INFO - Running setup.py (path:/tmp/pip-fVohgf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:56 INFO - Running setup.py (path:/tmp/pip-Ny5ODK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:00:56 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)) 22:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:56 INFO - Running setup.py (path:/tmp/pip-QLvlgk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:00:56 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)) 22:00:56 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)) 22:00:56 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)) 22:00:56 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)) 22:00:56 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)) 22:00:56 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)) 22:00:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:58 INFO - Downloading blessings-1.6.tar.gz 22:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:58 INFO - Installing collected packages: blessings 22:00:58 INFO - Running setup.py install for blessings 22:00:58 INFO - Successfully installed blessings 22:00:58 INFO - Cleaning up... 22:00:58 INFO - Return code: 0 22:00:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:00:58 INFO - Reading from file tmpfile_stdout 22:00:58 INFO - Current package versions: 22:00:58 INFO - argparse == 1.2.1 22:00:58 INFO - blessings == 1.6 22:00:58 INFO - blobuploader == 1.2.4 22:00:58 INFO - docopt == 0.6.1 22:00:58 INFO - manifestparser == 1.1 22:00:58 INFO - mozInstall == 1.12 22:00:58 INFO - mozcrash == 0.16 22:00:58 INFO - mozdebug == 0.1 22:00:58 INFO - mozdevice == 0.48 22:00:58 INFO - mozfile == 1.2 22:00:58 INFO - mozhttpd == 0.7 22:00:58 INFO - mozinfo == 0.9 22:00:58 INFO - mozleak == 0.1 22:00:58 INFO - mozlog == 3.1 22:00:58 INFO - moznetwork == 0.27 22:00:58 INFO - mozprocess == 0.22 22:00:58 INFO - mozprofile == 0.28 22:00:58 INFO - mozrunner == 6.11 22:00:58 INFO - mozscreenshot == 0.1 22:00:58 INFO - mozsystemmonitor == 0.0 22:00:58 INFO - moztest == 0.7 22:00:58 INFO - mozversion == 1.4 22:00:58 INFO - psutil == 3.1.1 22:00:58 INFO - requests == 1.2.3 22:00:58 INFO - wsgiref == 0.1.2 22:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:00:58 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')]} 22:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:58 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')]} 22:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:00:58 INFO - Using env: {'DISPLAY': ':0', 22:00:58 INFO - 'HOME': '/home/cltbld', 22:00:58 INFO - 'LANG': 'en_US.UTF-8', 22:00:58 INFO - 'LANGUAGE': 'en_US:en', 22:00:58 INFO - 'LOGNAME': 'cltbld', 22:00:58 INFO - 'MAIL': '/var/mail/cltbld', 22:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:58 INFO - 'MOZ_NO_REMOTE': '1', 22:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:58 INFO - 'NO_EM_RESTART': '1', 22:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:58 INFO - 'SHELL': '/bin/bash', 22:00:58 INFO - 'SHLVL': '1', 22:00:58 INFO - 'TERM': 'linux', 22:00:58 INFO - 'TMOUT': '86400', 22:00:58 INFO - 'USER': 'cltbld', 22:00:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:58 INFO - '_': '/tools/buildbot/bin/python'} 22:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 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)) 22:00:59 INFO - Cleaning up... 22:00:59 INFO - Return code: 0 22:00:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:00:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:00:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:00:59 INFO - Using env: {'DISPLAY': ':0', 22:00:59 INFO - 'HOME': '/home/cltbld', 22:00:59 INFO - 'LANG': 'en_US.UTF-8', 22:00:59 INFO - 'LANGUAGE': 'en_US:en', 22:00:59 INFO - 'LOGNAME': 'cltbld', 22:00:59 INFO - 'MAIL': '/var/mail/cltbld', 22:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:59 INFO - 'MOZ_NO_REMOTE': '1', 22:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:59 INFO - 'NO_EM_RESTART': '1', 22:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:00:59 INFO - 'SHELL': '/bin/bash', 22:00:59 INFO - 'SHLVL': '1', 22:00:59 INFO - 'TERM': 'linux', 22:00:59 INFO - 'TMOUT': '86400', 22:00:59 INFO - 'USER': 'cltbld', 22:00:59 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:59 INFO - '_': '/tools/buildbot/bin/python'} 22:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:59 INFO - Downloading/unpacking jsonschema 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:01 INFO - Downloading/unpacking functools32 (from jsonschema) 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:01 INFO - warning: no files found matching '*.txt' 22:01:01 INFO - no previously-included directories found matching 'build' 22:01:01 INFO - no previously-included directories found matching 'dist' 22:01:01 INFO - no previously-included directories found matching '.git*' 22:01:01 INFO - Installing collected packages: jsonschema, functools32 22:01:01 INFO - Running setup.py install for functools32 22:01:01 INFO - warning: no files found matching '*.txt' 22:01:01 INFO - no previously-included directories found matching 'build' 22:01:01 INFO - no previously-included directories found matching 'dist' 22:01:01 INFO - no previously-included directories found matching '.git*' 22:01:01 INFO - Successfully installed jsonschema functools32 22:01:01 INFO - Cleaning up... 22:01:01 INFO - Return code: 0 22:01:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:01:01 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')]} 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:01 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')]} 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0f0ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2926630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, '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': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', '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 22:01:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:01:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:01:01 INFO - Using env: {'DISPLAY': ':0', 22:01:01 INFO - 'HOME': '/home/cltbld', 22:01:01 INFO - 'LANG': 'en_US.UTF-8', 22:01:01 INFO - 'LANGUAGE': 'en_US:en', 22:01:01 INFO - 'LOGNAME': 'cltbld', 22:01:01 INFO - 'MAIL': '/var/mail/cltbld', 22:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:01 INFO - 'MOZ_NO_REMOTE': '1', 22:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:01 INFO - 'NO_EM_RESTART': '1', 22:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:01 INFO - 'SHELL': '/bin/bash', 22:01:01 INFO - 'SHLVL': '1', 22:01:01 INFO - 'TERM': 'linux', 22:01:01 INFO - 'TMOUT': '86400', 22:01:01 INFO - 'USER': 'cltbld', 22:01:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:01 INFO - '_': '/tools/buildbot/bin/python'} 22:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:01 INFO - Downloading/unpacking flake8 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:01:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:01:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:04 INFO - no previously-included directories found matching 'docs/_build' 22:01:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:01:04 INFO - Running setup.py install for pep8 22:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:01:04 INFO - no previously-included directories found matching 'docs/_build' 22:01:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:01:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:01:04 INFO - Cleaning up... 22:01:04 INFO - Return code: 0 22:01:04 INFO - Running post-action listener: _resource_record_post_action 22:01:04 INFO - Running post-action listener: _start_resource_monitoring 22:01:04 INFO - Starting resource monitoring. 22:01:04 INFO - ##### 22:01:04 INFO - ##### Running install step. 22:01:04 INFO - ##### 22:01:04 INFO - Running pre-action listener: _resource_record_pre_action 22:01:04 INFO - Running main action method: install 22:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:01:04 INFO - Reading from file tmpfile_stdout 22:01:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:01:04 INFO - Reading from file tmpfile_stdout 22:01:04 INFO - Output received: 22:01:04 INFO - Usage: mozinstall [options] installer 22:01:04 INFO - Options: 22:01:04 INFO - -h, --help show this help message and exit 22:01:04 INFO - -d DEST, --destination=DEST 22:01:04 INFO - Directory to install application into. [default: 22:01:04 INFO - "/builds/slave/test-pgo"] 22:01:04 INFO - --app=APP Application being installed. [default: firefox] 22:01:04 INFO - mkdir: /builds/slave/test-pgo/build/application 22:01:04 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'] 22:01:04 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 22:01:20 INFO - Reading from file tmpfile_stdout 22:01:20 INFO - Output received: 22:01:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:01:20 INFO - Running post-action listener: _resource_record_post_action 22:01:20 INFO - ##### 22:01:20 INFO - ##### Running run-tests step. 22:01:20 INFO - ##### 22:01:20 INFO - Running pre-action listener: _resource_record_pre_action 22:01:20 INFO - Running main action method: run_tests 22:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:01:20 INFO - Python 2.7.3 22:01:20 INFO - Return code: 0 22:01:20 INFO - grabbing minidump binary from tooltool 22:01:20 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')]} 22:01:20 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 0x29b7840>, '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 0x29246b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2924b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:01:20 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 22:01:20 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 22:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:20 INFO - Return code: 0 22:01:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:01:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:01:22 INFO - Return code: 0 22:01:22 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 22:01:22 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:01:22 INFO - Using env: {'DISPLAY': ':0', 22:01:22 INFO - 'HOME': '/home/cltbld', 22:01:22 INFO - 'LANG': 'en_US.UTF-8', 22:01:22 INFO - 'LANGUAGE': 'en_US:en', 22:01:22 INFO - 'LOGNAME': 'cltbld', 22:01:22 INFO - 'MAIL': '/var/mail/cltbld', 22:01:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:22 INFO - 'MOZ_NO_REMOTE': '1', 22:01:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:22 INFO - 'NO_EM_RESTART': '1', 22:01:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:22 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:01:22 INFO - 'SHELL': '/bin/bash', 22:01:22 INFO - 'SHLVL': '1', 22:01:22 INFO - 'TERM': 'linux', 22:01:22 INFO - 'TMOUT': '86400', 22:01:22 INFO - 'USER': 'cltbld', 22:01:22 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774', 22:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:22 INFO - '_': '/tools/buildbot/bin/python'} 22:01:22 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:01:22 INFO - mozversion application_buildid: 20160123193118 22:01:22 INFO - mozversion application_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 22:01:22 INFO - mozversion application_display_name: Nightly 22:01:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:22 INFO - mozversion application_name: Firefox 22:01:22 INFO - mozversion application_remotingname: firefox 22:01:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:01:22 INFO - mozversion application_vendor: Mozilla 22:01:22 INFO - mozversion application_version: 46.0a1 22:01:22 INFO - mozversion platform_buildid: 20160123193118 22:01:22 INFO - mozversion platform_changeset: d6d81655dd9e146c300a64c0fcaeb04ca3300a19 22:01:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:01:22 INFO - mozversion platform_version: 46.0a1 22:01:22 INFO - using testdate: 1453615282 22:01:22 INFO - actual date: 1453615282 22:01:22 INFO - starting webserver on 'localhost:33405' 22:01:22 INFO - SUITE-START | Running 3 tests 22:01:22 INFO - TEST-START | dromaeo_css 22:01:22 INFO - operating with platform_type : linux_ 22:01:22 INFO - Initialising browser for dromaeo_css test... 22:01:22 INFO - TEST-INFO | started process 8297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGhZpcP/profile http://localhost:33405/getInfo.html) 22:01:26 INFO - PROCESS | 8297 | 22:01:26 INFO - PROCESS | 8297 | (process:8378): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:01:27 INFO - PROCESS | 8297 | __metrics Screen width/height:1600/1200 22:01:27 INFO - PROCESS | 8297 | colorDepth:24 22:01:27 INFO - PROCESS | 8297 | Browser inner width/height: 1024/697 22:01:27 INFO - PROCESS | 8297 | __metrics 22:01:27 INFO - PROCESS | 8297 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:01:28 INFO - TEST-INFO | 8297: exit 0 22:01:28 INFO - Browser initialized. 22:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:28 INFO - TEST-INFO | started process 8427 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGhZpcP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:29 INFO - PROCESS | 8427 | 22:01:29 INFO - PROCESS | 8427 | (process:8484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:01:39 INFO - PROCESS | 8427 | RSS: Main: 152203264 22:01:39 INFO - PROCESS | 8427 | 22:02:29 INFO - PROCESS | 8427 | 1453615349477 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] 22:04:38 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33405/tests/dromaeo/cssquery-ext.html) 22:04:39 INFO - PROCESS | 8427 | RSS: Main: 160874496 22:04:39 INFO - PROCESS | 8427 | 22:07:41 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-ext.html (next: http://localhost:33405/tests/dromaeo/cssquery-jquery.html) 22:07:42 INFO - PROCESS | 8427 | RSS: Main: 157249536 22:07:42 INFO - PROCESS | 8427 | 22:10:44 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33405/tests/dromaeo/cssquery-mootools.html) 22:10:44 INFO - PROCESS | 8427 | RSS: Main: 155828224 22:10:44 INFO - PROCESS | 8427 | 22:13:46 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33405/tests/dromaeo/cssquery-prototype.html) 22:13:47 INFO - PROCESS | 8427 | RSS: Main: 153358336 22:13:47 INFO - PROCESS | 8427 | 22:16:49 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33405/tests/dromaeo/cssquery-yui.html) 22:16:50 INFO - PROCESS | 8427 | RSS: Main: 153845760 22:16:50 INFO - PROCESS | 8427 | 22:19:52 INFO - PROCESS | 8427 | Cycle 1(1): loaded http://localhost:33405/tests/dromaeo/cssquery-yui.html (next: http://localhost:33405/tests/dromaeo/cssquery-dojo.html) 22:19:53 INFO - PROCESS | 8427 | RSS: Main: 156835840 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | __start_tp_report 22:19:53 INFO - PROCESS | 8427 | _x_x_mozilla_page_load 22:19:53 INFO - PROCESS | 8427 | _x_x_mozilla_page_load_details 22:19:53 INFO - PROCESS | 8427 | |i|pagename|runs| 22:19:53 INFO - PROCESS | 8427 | |0;dojo.html;3234.741220702344;3242.432574299497;3262.5921759780026;3288.2272665923497;3296.8681252749893;5223.347081614798;5350.0904846176145;5365.91951120733;5385.003774301752;5387.568994480442;5251.684898906059;5271.710055946922;5303.840884773454;5314.707691076989;5335.093034184189;4797.448293446263;4824.059308434857;4859.2225243960975;4910.75446227689;4950.925736113961;764.8049196688946;4774.594159496447;4781.139394908915;4865.708057516543;4889.26661000851;4832.830850920236;4862.270659401082;4877.46347901734;4884.267359896008;4892.119418504668;4886.389201349832;4912.410510738699;4997.600191984632;5027.572656324217;5029.723365214912;4746.43042834862;4760.285957106427;4823.348847905523;4842.467328593887;4995.550400463976;5118.4625614310335;5125.410577783566;5141.948580514184;5154.639175257734;5207.244949482304;5647.040003199466;5666.178404131378;5678.205051292823;5680.46035626619;5698.31620205578;5598.832035038955;5626.9437305626825;5753.482186603226;5775.5957083004205;5790.13148027795;5418.891622167574;5453.727313634303;5455.454454554552;5455.8363249102595;5466.6993315367245;5820.156077368758;5940;5947.9702601486715;5951.940480595225;5966.701664916737;5578.358488773762;5643.294588176478;5670.376258611549;5686.317641882918;5737.655740655574;5845.853853653693;5850.3564607893095;5881.117832325185;5894.115882617642;5895.793647222326;5537.889242215133;5786.218860453785;5835.591508594358;5868.853278667982;5871.089981052944;5494.2857428534835;5503.862403439866;5522.3649280333275;5549.139883318092;5549.19536667181;4414.646828253732;4424.557544245614;4430.579094985971;4454.7549884756645;4459.264221403432;3958.990457433336;3965.8810235692977;3978.661813745864;3999.2601368746873;4045.1707399982934;5174;5183.118869792144;5267.762950667229;5418.133098704188;5477.397486276506;5610.158476228598;5648.8870222595315;5696.943030569724;5740.569457290637;5784.248047753849;5362.088444964365;5366.704831234241;5384.5692344612335;5398.91901621476;5399.217113518518;4812.735299558488;4893.996730670276;4901.044296362246;4916.041371932511;4959.801607935714;5865.589408741347;5931;5999.1901093351835;6009.759609615567;6050.9394906050375;5746.511546518593;5754.625949313281;5757.4242575743765;5760.855978600401;5767.625104368202;5739.339975902824;5876.764929402947;5902.350741418355;5935.584509084322;5950.315713692808;5647.6893770843;5700.458456446631;5708.771649133988;5715.799947001835;5759.596828221985;5711.48596626289;5749.453801888814;5752.827415177551;5756.740946657326;5779.884402312015;5492.340919089735;5550.361708403424;5580.497755202051;5598.468145526169;5642.379338272869;5613.494785469164;5630.831075067755;5634.7464364104535;5649.915251271152;5690.829275121753;5508.724563771875;5515.889682206413;5529.585281103853;5530.308711411074;5534.446555344433;5473.67157970523;5556.499915007507;5605.5795815313195;5623.915641265467;5639.182318563703;5562.721863906708;5564.10974244119;5578.246936663499;5619.9719001406365;5623.943760562342 22:19:53 INFO - PROCESS | 8427 | |1;ext.html;531.9840404787856;540.8053100883683;549.1460778489447;560.2156980227679;570.3441042800779;38360.23279534411;38950.22099558007;38987.610123898754;39009.41485877707;39026.60973390265;42089;42379.78810105953;42397.78801105998;42785.57214427855;42821.14357712852;8522.957385213065;8689.478631282143;8775.692850750225;8779.34154938379;8802.955985220096;8441.95779021107;8575.056743758181;8627.43921645091;8658.307335413152;8661.3937024408;8599.312055035582;8715.694950676727;8724.389292749478;8737.21365077143;8770.6930257441;8581.356398270123;8622.784430389227;8700.129987001312;8703.782405439882;8714.520701361422;8502.277306428961;8566.657333706644;8594;8659.307255419551;8674.04585495595;39126;39349.21301573981;39355.80322098371;39380.21239575221;39552.60447395518;3187.5218717192374;3237.546743455918;3318.2699806042633;3368.6631336866117;3688.778673279585;29608.55587166194;30168;30371.544426833614;30705.38589228225;31511.897083601965;4083.367078102869;4084.4485994390675;4100.118474527991;4117.300058989949;4126.896827579305;262037;262661.9999999981;263839;265113;266639;52058.21912671313;52984.20523692148;59099.40900590939;59379;59408.10887836686;53661.46338536565;53748.46251537435;54025.189622155696;54170;54200.45799541954;13797.793033104512;13954.372053257628;13957.581272561636;14012.649683757987;14051.156930584199;10698.73253168677;10724.517396717167;10725.946370268099;10765.730856728644;10785.89214107849;19292.1318540666;19504.344706632855;20383.388498344775;20426.38720838377;20464.488387790425;7928;8016.038075430985;8063.556504392197;8073.878891816627;8092.878606820902;918.150710592699;982.8427451607708;993.5529011944653;1033.03927347566;1052.4264275969463;25240.621390679156;29223.56164657532;29269.707302927123;29311.85344073266;29723.85138074296;1012.8227560177087;1030.9742256443649;1039.262123892045;1118.7874303882236;1134.8694900086596;15113.16877571744;15212.174539055162;15517.146556939477;16310;17362.39231626887;383069;384617;384734;386147;386716;55581;55589.444105558425;56076.43923560712;56200.15699764507;56240.71879640576;1343.6909510812568;1347.3398034962797;1358.8233529641282;1367.43934986655;1370.766969615148;29621.851890740407;30246.30443666924;30646.233844153183;30712.385752285278;30833.383332332778;46261;46416.535834641225;46676.53323466722;46972.7651361741;47238.29142562933;307522;309919;310529;310770;311802;30571;42903.35644965265;43578.34632480452;43944.34083488814;44150.55849441593;41003;42818;43091.138177236906;43493.34759978666;43759;35598.28803423969;35957.64042359543;35971;36425.08937276589;37229.81385093057;36033.27933441264;36940.44589331216;37154;37433;37471;34781;34912;35457;35485.64514354823;35494.822525887204;30968.380632387678;31498.582563784228;33327.33345333128;33342.833285834386;33522.66477335196;25141.24576262715;25168.74831251664;25432.74567254304;25635.743642563335;25671.486570268116 22:19:53 INFO - PROCESS | 8427 | |2;jquery.html;365.8975486863678;368.3130960758185;368.86167687117324;371.67849809914435;372.50642898159913;16033.358665653375;16433.342666293334;16997;17042.48872533826;17877.55306117346;10833.404162771065;10965.067969222626;16023.759643605326;16245.106519141442;16401.753973690404;4899.0446862861845;5081.390233172025;5192.091384007803;5282.709450980195;5295.735213239342;5172.482751724835;5304.257403963448;5314.973425132869;5374.086405311106;5401.864953376158;5090.974545127269;5289.841304760844;5319.627626066177;5364.785408583652;5392.0294347017525;5222.112240919015;5231.267622532849;5255.395629502618;5259.421463638997;5599.63602365849;5318.069337865858;5346.946530534723;5359.062164121302;5360.035193665139;5367.865803354908;12856;12941.935290323489;12998.740025199442;13001.219926804328;17688.76178667494;2046.7850875657991;2162.426956856434;2171.3051823416513;2189.8576592521595;2293.121629956823;9096.181343679034;9204.585793639302;9243;9261.583228754722;9487.430754154704;1745.1099939031185;1765.143905205974;1789.3826629812693;1815.0289595066708;1841.0702595189343;50517.74741126307;50826.7458662708;52668.736656316854;52846;53135.20297195545;9814.116729494379;9949.900500995042;10026.248031397674;10094.09153176203;10152.086312231786;13175.67060823487;13188.340582970814;13198.934005330104;13234.73530529384;13260.668483287995;7104.502684812117;7178.2103968563415;7179.641017949186;7187.281271872771;7234.348908598146;6771.864562708817;6986.860262794716;6998.125234345707;7059.082319298561;7117.786466406016;4361.781910904442;4460.219461594208;4460.50934397216;4482.148391805546;4483.529229430928;1706.8037175724703;1806.7741532308462;1846.7322238275374;1848.1775609853755;1863.5900101977543;852.3820230333083;915.3729695158704;922.1930810540777;924.3483344242427;1000.214831357381;15227.619309517351;15639.68720625604;15761.369545218293;16288.755668664979;16354.509364718839;856.9914300857037;915.8443064678887;941.1576638908276;960.5677445149711;981.7588610410825;8832.116788321246;8843.380963332505;8912.970807326275;8921.687740929035;9172.908270917205;527186;527448;531375;549675;565751;42755.78622106932;43134.35298470463;43395.56604433915;67165;67793;1130.2935665209245;1142.2461175624048;1143.4225716013527;1152.4180288954024;1154.249737670521;13410.32948352598;13517.932410337886;13532.188068715908;13602.38789254466;13771.655708607364;28102.156935291972;28994.275143120747;29297.560536591543;29955.365845124667;29986.95045673391;40980.38529422002;40986.79506602448;41132.58867411407;41377.37933931054;41443.7927810359;6990.497043135751;7011.439084873095;7184.173820010766;7200.71197152129;7248.275172482709;8288.917110829056;10251.53963048848;10406.635767748092;10604.363738175734;10703.518341674799;8788.472691638523;9323.440593564408;9378.624855005723;9381.718548443558;9561.952190239283;9600.519974001132;9688.224942004763;9730.659426920023;9759;10019.949900250453;9532.714018579454;9760.609575616896;9811.362261452983;9884.209263259067;9909.256805739455;7281.453890958305;7460.104787425544;7558.433117516318;7575.886361704469;7583.127940286938;9163.77090572741;9694.22446204288;9810.104477462959;9875.901240987498;9939.652112176329 22:19:53 INFO - PROCESS | 8427 | |3;mootools.html;1413.6183230527758;1430.8497607751185;1557.5638821130087;1735.366591194213;1755.7103077992124;7531.924680753191;7552.622368881562;7790.8441831163345;7800.609969501531;7850.76447706569;7642.503237289572;7746.419018573615;7749.418793590489;7799.220077992198;7801.492902961303;2326.4765427778743;2359.988200059006;2369.312899259213;2376.4652953085506;2384.76152384761;2357.457784709518;2369.7037870266217;2381.7022872140983;2384.606539920911;2388.4984153327823;2201.7688142745023;2268.421552504109;2272.068451934707;2273.102124660758;2286.622707253301;2310.803581695558;2322.477442575407;2336.1356298169703;2345.2495201535517;2346.683197768305;2327.185485080225;2344.167820423759;2345.1909091363455;2349.189529612281;2354.599718047919;7880.605969701492;7917.089534703525;7952.443328966975;7976.242256985577;7981.640826162837;4797.736124513151;4843.9515604843855;4908.558229759339;4925.21196608541;4928.1129396708575;3067.6165479315086;3168.461361568539;3186.4423725848114;3201.439748044106;3231.2406584452633;1094.934303941766;1108.6396921000708;1110.9611163609316;1142.520141540555;1178.6346232667815;10714.9464252679;10804.72988175294;10810.189235807346;10823.945880270549;10843.457827108692;4104.91790164195;4285.871423857289;4306.956930430718;4307.181635489247;4320;8706.216440520384;8718.520481373458;8741.519216443157;8753.431026983226;8771.736847894574;4755.619550435957;4805.903881922342;4807.519248075165;4815.22956326986;4841.685290456109;4398.516163222043;4403.471583409947;4404.66964977628;4408.184485870124;4464.308032255006;3489.8778542750883;3524.101354154674;3531.1878267998504;3568.553930758655;3572.5712914449914;1062.2988827373897;1100.9339439633648;1108.6673997800629;1111.6053800900563;1120.0815331428314;862.7066797288952;1053.031211285619;1096.4956120184645;1111.8776934537195;1264.9683757906125;7280.6723697433745;7305.598192099379;7326.377257933135;7340.009098771704;7349.742759003409;1128.1024061866397;1178.1693905796392;1185.911056670736;1195.665213740154;1206.5234232478297;5647.943520564824;5656.547476201894;5687.43125687428;5729;5761.88476230473;8974.28205743539;9223.216026637676;9264.861027084598;9307.953460232655;9338.299627527962;9124.771880703036;9191.402558833788;9197.218236449977;9228.769280768034;9306.86039709405;7236.34872861445;7358.668859901317;7374.520656157332;7407.740729074349;7419.85160296791;6982.371586557234;6984.3364880336285;7011.26381729911;7026.402755765613;7072.83298255782;8259.463134896212;8366.954130733659;8394.706185283485;8401.663933442594;8431.704890328809;8503.489790612583;8513.489190648581;8519.574021298786;8601.784955376166;8617.65529378843;6620.933790662224;6706.061151438705;6722.865542689216;6723.798286051427;6728.091707619409;7531.774046778605;7537.736179233701;7538.849223015399;7592.278733520307;7594.8860767087435;6365.2361716594305;6857.5199736018;7126.358627723323;7148.356647901714;7245.094363204599;6330.335314792064;6498.707558159988;6788.083608712761;6871.690773915086;6890.20762612306;6655.134832471747;6701.564398314094;6760.628165450948;6777.864442711217;6783.626900520519;6233.875322493615;6288.151099601495;6299.275583307795;6310;6312.116303717575;6389.7763578274535;6399.840003999937;6403.647799370893;6423.935760642521;6442.774502892376 22:19:53 INFO - PROCESS | 8427 | |4;prototype.html;340.77508844162855;343.5962743776064;346.59275351462026;349.9685028347449;350.9017475106969;6156;6216.720247588858;6239.438450539451;6270.372962703727;6399.232092148949;6181.6600086995195;6203.131561581382;6215.59598626089;6224.906626400608;6251.968740156304;4656.44122705275;4736.076465089309;4738.4313882334;4741.90516189676;4742.05158968206;4689.296605509184;4689.57793798558;4717.033008233304;4753.595944344735;4756.571908528232;4590.127875703605;4622.097614910761;4644.140833945714;4685.83599574015;4723.220668589679;4675.345451636774;4681.929771053454;4683.227267500858;4689.531046895318;4691.319758635013;4077.3476243801147;4083.97958010211;4097.569755175723;4104.979475102636;4111.876643700693;5801.593888427812;5802.622829516068;5819.24349834523;5836.445537673914;5846.736896839652;5387.892242155174;5454.34547854256;5463.699496527689;5502.064649009638;5510.531604813596;6509.707063182121;6521.184851893513;6522.054302126166;6526.869462610721;6547.116139321179;4532.4334458192725;4564.612007979325;4569.634429245652;4574.19951508488;4575.748333841638;6656.267810540789;6754.729810807562;6766.729330826761;6798.422134118606;6821.4542836572955;4637.281221410687;4665.113628410591;4667.8599642010795;4671.766411679402;4676.3686902267755;4687.554682305175;4716.528347165256;4720.0559888022535;4720.701807003102;4720.716756994591;5454.400015998237;5466.945330546644;5467.535259502987;5471.945280547144;5475.370332411744;6465.353464653591;6545.443637290884;6597.30728273534;6632.668366581652;6644.435223006002;1658.1874881308072;1681.1090122235235;1681.6720739455689;1685.5112017515028;1685.8145603983553;1097.928634638746;1101.30067407197;1117.3184357541893;1117.502711293483;1119.2892513254142;6219.40915613016;6226.657533835682;6254.999200128049;6256.874862502816;6268.686565671698;6809.080774095532;6809.182898052166;6815.386615204656;6820.658967051628;6839.213490448563;5953.464188222994;6032.155498230251;6151.630902145886;6175.5677102602385;6202;3679.889603311905;3704.81475926208;3707.480952666629;3744.9625503744614;3758.0229140423685;7172.354488096096;7233.095863017123;7238.963805180941;7240.094988126484;7244.855102897913;6885.001674757233;7048.436125109979;7059.5764254144915;7062.081929349151;7067.151941767021;7059.576425414389;7139.535930164523;7204.639768011683;7214.74748383804;7245.38414234796;6811.012403201607;6852.383285504328;6856.897146542706;6859.691313890987;6880.621565813928;6701.932980670326;6779.220389655253;6801.727930882709;6803.489738269748;6828.897566536605;7175.928240717526;7176.461765367514;7178.784636460915;7183.066201393785;7187.425005999612;4704.317873908332;4708.6468514860835;4710.552497512731;4713.505081966481;4719.69321994083;6770.796876093725;6845.691943862438;6862.897056544256;6866.34769696878;6915.654217289216;6614.437772789367;6621.205455345389;6635.502337324623;6650;6663.966680166568;6648.202215734143;6688.7324507019175;6689.832754181184;6699.062131301719;6703.396694297537;6447;6528.510361722795;6567.310432404529;6584.242812076673;6593.835154121185;6665.333466653296;6708.396244338033;6727.394534491919;6732.259451460433;6741.865162696817;6449.258335291502;6510.609363438209;6555.147830781968;6565.934340656532;6585.96707016481 22:19:53 INFO - PROCESS | 8427 | |5;yui.html;782.3936449251829;788.0385929166415;838.6645341863253;842.1073661918371;900.7838118851475;13314.93342533286;13318.267495287755;13325.46698132076;13350.1989880607;13476.52832150875;12086.637400877966;12502.312372819491;12505.374731263446;12520.123591348609;12546;747.9813004674872;756.5422919133928;800.8838718385831;801.6432687454085;806.7176488229131;779.4504874063772;781.6834182156235;788.2511613966726;788.333857890082;792.18405042806;819.3772732723114;823.1768231768232;825.6821123867294;825.8926339575846;828.3000864269683;811.350919264586;811.6347643560392;815.3110621524802;815.6166601697253;819.4919150126959;599.2449513612836;600.642617642502;602.0457574744036;604.4348534120611;605.33110912442;13315;13347.532836350681;13406.664833379145;13446.731065378637;13513.459461621524;11532.711682207928;11636;11731.17881748278;11790.292582445081;11942.701432464171;10278.33190842593;10463.738406539822;10484;10506.106980906632;10886.564537418493;3613.385724426854;3632.5640923089136;3654.104744337628;3683.9447408288897;3726.347889119393;43755.12489750219;43811.12377752459;44033;44082.55917440817;44635.99999999967;9629.807403851884;9914.107730304308;9918.950405248072;10052.894181640013;10274.537645805807;16387.508374748777;16413.343466261456;16433.178341082898;16440.83559164417;16448.917755411145;6954.269801670853;7010.509264351548;7039.683214255371;7048.788536343918;7183.994240806292;4118.5057793064425;4296.5273819879785;4329.177456283296;4341;4343.391925130484;3096.752259819209;3106.5340198970334;3120.812751234888;3129.108204161803;3138.2938838761097;595.5354823237882;607.3986753114473;608.996955015222;623.9500839932795;630.4294613374904;622.1538707357989;637.4231320654815;656.2584279763931;657.8223879552589;693.8022663540867;8958.507282099417;9052.909470905339;9056.773580660536;9067.727968160965;9276.165145136834;588.6056342250703;590;635.1742734445203;648.1120864415686;670.2191946382508;4017.337139371971;4054.2296963576828;4057.634812866856;4168.103857670615;4170.4995400551525;50559.24161137586;50852;50921.23618145731;50949.745251274246;50995.23507147396;48880.7555962225;48901.266481002815;48996.75501622469;49027;49097.75451122793;44543.331850022274;44777;44892;44907.101857962654;45463.54536454659;8047.315978141924;8126.512409255463;8641.481511109354;8800.427972181787;8824.691135810215;32549.837250813594;33076.1730956728;33088;34599.82700086483;34600.9619711409;42493.362599560416;42555.78722106494;42651.7867410661;44004.33993490036;44096.779516102215;10447.843282350923;10725.517351719347;10838.566457341618;10843.620473283398;11189.72025699364;11473.426328683365;11602.70993225176;11666.416679166177;11726.94136529312;12399.380030998595;11458.541658333574;11488.425578721197;11637.88362116402;11921.880781192078;11934.761304774029;11014.118870490182;11195.664130076111;11205.215634905479;11206.215564910379;11526.423678816192;10558.212768485919;11028;11142.610008649659;11218.719532011764;11543.538258469904;9023.278137749096;9234.1689247968;9388.624455021996;9433.622655093994;9470.431774093577;8306.958465207636;8907.599158037774;9260.53697315118;9366;9373.62338208737 22:19:53 INFO - PROCESS | 8427 | __end_tp_report 22:19:53 INFO - PROCESS | 8427 | __start_cc_report 22:19:53 INFO - PROCESS | 8427 | _x_x_mozilla_cycle_collect,305 22:19:53 INFO - PROCESS | 8427 | __end_cc_report 22:19:53 INFO - PROCESS | 8427 | __startTimestamp1453616393113__endTimestamp 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | ------- Summary: start ------- 22:19:53 INFO - PROCESS | 8427 | Number of tests: 6 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#0] dojo.html Cycles:165 Average:5299.72 Median:5530.31 stddev:682.32 (12.3%) stddev-sans-first:664.90 22:19:53 INFO - PROCESS | 8427 | Values: 3234.7 3242.4 3262.6 3288.2 3296.9 5223.3 5350.1 5365.9 5385.0 5387.6 5251.7 5271.7 5303.8 5314.7 5335.1 4797.4 4824.1 4859.2 4910.8 4950.9 764.8 4774.6 4781.1 4865.7 4889.3 4832.8 4862.3 4877.5 4884.3 4892.1 4886.4 4912.4 4997.6 5027.6 5029.7 4746.4 4760.3 4823.3 4842.5 4995.6 5118.5 5125.4 5141.9 5154.6 5207.2 5647.0 5666.2 5678.2 5680.5 5698.3 5598.8 5626.9 5753.5 5775.6 5790.1 5418.9 5453.7 5455.5 5455.8 5466.7 5820.2 5940.0 5948.0 5951.9 5966.7 5578.4 5643.3 5670.4 5686.3 5737.7 5845.9 5850.4 5881.1 5894.1 5895.8 5537.9 5786.2 5835.6 5868.9 5871.1 5494.3 5503.9 5522.4 5549.1 5549.2 4414.6 4424.6 4430.6 4454.8 4459.3 3959.0 3965.9 3978.7 3999.3 4045.2 5174.0 5183.1 5267.8 5418.1 5477.4 5610.2 5648.9 5696.9 5740.6 5784.2 5362.1 5366.7 5384.6 5398.9 5399.2 4812.7 4894.0 4901.0 4916.0 4959.8 5865.6 5931.0 5999.2 6009.8 6050.9 5746.5 5754.6 5757.4 5760.9 5767.6 5739.3 5876.8 5902.4 5935.6 5950.3 5647.7 5700.5 5708.8 5715.8 5759.6 5711.5 5749.5 5752.8 5756.7 5779.9 5492.3 5550.4 5580.5 5598.5 5642.4 5613.5 5630.8 5634.7 5649.9 5690.8 5508.7 5515.9 5529.6 5530.3 5534.4 5473.7 5556.5 5605.6 5623.9 5639.2 5562.7 5564.1 5578.2 5620.0 5623.9 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#1] ext.html Cycles:180 Average:48783.56 Median:384675.50 stddev:84905.56 (22.1%) stddev-sans-first:85066.45 22:19:53 INFO - PROCESS | 8427 | Values: 532.0 540.8 549.1 560.2 570.3 38360.2 38950.2 38987.6 39009.4 39026.6 42089.0 42379.8 42397.8 42785.6 42821.1 8523.0 8689.5 8775.7 8779.3 8803.0 8442.0 8575.1 8627.4 8658.3 8661.4 8599.3 8715.7 8724.4 8737.2 8770.7 8581.4 8622.8 8700.1 8703.8 8714.5 8502.3 8566.7 8594.0 8659.3 8674.0 39126.0 39349.2 39355.8 39380.2 39552.6 3187.5 3237.5 3318.3 3368.7 3688.8 29608.6 30168.0 30371.5 30705.4 31511.9 4083.4 4084.4 4100.1 4117.3 4126.9 262037.0 262662.0 263839.0 265113.0 266639.0 52058.2 52984.2 59099.4 59379.0 59408.1 53661.5 53748.5 54025.2 54170.0 54200.5 13797.8 13954.4 13957.6 14012.6 14051.2 10698.7 10724.5 10725.9 10765.7 10785.9 19292.1 19504.3 20383.4 20426.4 20464.5 7928.0 8016.0 8063.6 8073.9 8092.9 918.2 982.8 993.6 1033.0 1052.4 25240.6 29223.6 29269.7 29311.9 29723.9 1012.8 1031.0 1039.3 1118.8 1134.9 15113.2 15212.2 15517.1 16310.0 17362.4 383069.0 384617.0 384734.0 386147.0 386716.0 55581.0 55589.4 56076.4 56200.2 56240.7 1343.7 1347.3 1358.8 1367.4 1370.8 29621.9 30246.3 30646.2 30712.4 30833.4 46261.0 46416.5 46676.5 46972.8 47238.3 307522.0 309919.0 310529.0 310770.0 311802.0 30571.0 42903.4 43578.3 43944.3 44150.6 41003.0 42818.0 43091.1 43493.3 43759.0 35598.3 35957.6 35971.0 36425.1 37229.8 36033.3 36940.4 37154.0 37433.0 37471.0 34781.0 34912.0 35457.0 35485.6 35494.8 30968.4 31498.6 33327.3 33342.8 33522.7 25141.2 25168.7 25432.7 25635.7 25671.5 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#2] jquery.html Cycles:180 Average:26351.69 Median:5243.33 stddev:88082.22 (1679.9%) stddev-sans-first:88307.70 22:19:53 INFO - PROCESS | 8427 | Values: 365.9 368.3 368.9 371.7 372.5 16033.4 16433.3 16997.0 17042.5 17877.6 10833.4 10965.1 16023.8 16245.1 16401.8 4899.0 5081.4 5192.1 5282.7 5295.7 5172.5 5304.3 5315.0 5374.1 5401.9 5091.0 5289.8 5319.6 5364.8 5392.0 5222.1 5231.3 5255.4 5259.4 5599.6 5318.1 5346.9 5359.1 5360.0 5367.9 12856.0 12941.9 12998.7 13001.2 17688.8 2046.8 2162.4 2171.3 2189.9 2293.1 9096.2 9204.6 9243.0 9261.6 9487.4 1745.1 1765.1 1789.4 1815.0 1841.1 50517.7 50826.7 52668.7 52846.0 53135.2 9814.1 9949.9 10026.2 10094.1 10152.1 13175.7 13188.3 13198.9 13234.7 13260.7 7104.5 7178.2 7179.6 7187.3 7234.3 6771.9 6986.9 6998.1 7059.1 7117.8 4361.8 4460.2 4460.5 4482.1 4483.5 1706.8 1806.8 1846.7 1848.2 1863.6 852.4 915.4 922.2 924.3 1000.2 15227.6 15639.7 15761.4 16288.8 16354.5 857.0 915.8 941.2 960.6 981.8 8832.1 8843.4 8913.0 8921.7 9172.9 527186.0 527448.0 531375.0 549675.0 565751.0 42755.8 43134.4 43395.6 67165.0 67793.0 1130.3 1142.2 1143.4 1152.4 1154.2 13410.3 13517.9 13532.2 13602.4 13771.7 28102.2 28994.3 29297.6 29955.4 29987.0 40980.4 40986.8 41132.6 41377.4 41443.8 6990.5 7011.4 7184.2 7200.7 7248.3 8288.9 10251.5 10406.6 10604.4 10703.5 8788.5 9323.4 9378.6 9381.7 9562.0 9600.5 9688.2 9730.7 9759.0 10019.9 9532.7 9760.6 9811.4 9884.2 9909.3 7281.5 7460.1 7558.4 7575.9 7583.1 9163.8 9694.2 9810.1 9875.9 9939.7 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#3] mootools.html Cycles:180 Average:5439.25 Median:6293.71 stddev:2776.66 (44.1%) stddev-sans-first:2767.96 22:19:53 INFO - PROCESS | 8427 | Values: 1413.6 1430.8 1557.6 1735.4 1755.7 7531.9 7552.6 7790.8 7800.6 7850.8 7642.5 7746.4 7749.4 7799.2 7801.5 2326.5 2360.0 2369.3 2376.5 2384.8 2357.5 2369.7 2381.7 2384.6 2388.5 2201.8 2268.4 2272.1 2273.1 2286.6 2310.8 2322.5 2336.1 2345.2 2346.7 2327.2 2344.2 2345.2 2349.2 2354.6 7880.6 7917.1 7952.4 7976.2 7981.6 4797.7 4844.0 4908.6 4925.2 4928.1 3067.6 3168.5 3186.4 3201.4 3231.2 1094.9 1108.6 1111.0 1142.5 1178.6 10714.9 10804.7 10810.2 10823.9 10843.5 4104.9 4285.9 4307.0 4307.2 4320.0 8706.2 8718.5 8741.5 8753.4 8771.7 4755.6 4805.9 4807.5 4815.2 4841.7 4398.5 4403.5 4404.7 4408.2 4464.3 3489.9 3524.1 3531.2 3568.6 3572.6 1062.3 1100.9 1108.7 1111.6 1120.1 862.7 1053.0 1096.5 1111.9 1265.0 7280.7 7305.6 7326.4 7340.0 7349.7 1128.1 1178.2 1185.9 1195.7 1206.5 5647.9 5656.5 5687.4 5729.0 5761.9 8974.3 9223.2 9264.9 9308.0 9338.3 9124.8 9191.4 9197.2 9228.8 9306.9 7236.3 7358.7 7374.5 7407.7 7419.9 6982.4 6984.3 7011.3 7026.4 7072.8 8259.5 8367.0 8394.7 8401.7 8431.7 8503.5 8513.5 8519.6 8601.8 8617.7 6620.9 6706.1 6722.9 6723.8 6728.1 7531.8 7537.7 7538.8 7592.3 7594.9 6365.2 6857.5 7126.4 7148.4 7245.1 6330.3 6498.7 6788.1 6871.7 6890.2 6655.1 6701.6 6760.6 6777.9 6783.6 6233.9 6288.2 6299.3 6310.0 6312.1 6389.8 6399.8 6403.6 6423.9 6442.8 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#4] prototype.html Cycles:180 Average:5523.39 Median:6222.16 stddev:1681.54 (27.0%) stddev-sans-first:1640.65 22:19:53 INFO - PROCESS | 8427 | Values: 340.8 343.6 346.6 350.0 350.9 6156.0 6216.7 6239.4 6270.4 6399.2 6181.7 6203.1 6215.6 6224.9 6252.0 4656.4 4736.1 4738.4 4741.9 4742.1 4689.3 4689.6 4717.0 4753.6 4756.6 4590.1 4622.1 4644.1 4685.8 4723.2 4675.3 4681.9 4683.2 4689.5 4691.3 4077.3 4084.0 4097.6 4105.0 4111.9 5801.6 5802.6 5819.2 5836.4 5846.7 5387.9 5454.3 5463.7 5502.1 5510.5 6509.7 6521.2 6522.1 6526.9 6547.1 4532.4 4564.6 4569.6 4574.2 4575.7 6656.3 6754.7 6766.7 6798.4 6821.5 4637.3 4665.1 4667.9 4671.8 4676.4 4687.6 4716.5 4720.1 4720.7 4720.7 5454.4 5466.9 5467.5 5471.9 5475.4 6465.4 6545.4 6597.3 6632.7 6644.4 1658.2 1681.1 1681.7 1685.5 1685.8 1097.9 1101.3 1117.3 1117.5 1119.3 6219.4 6226.7 6255.0 6256.9 6268.7 6809.1 6809.2 6815.4 6820.7 6839.2 5953.5 6032.2 6151.6 6175.6 6202.0 3679.9 3704.8 3707.5 3745.0 3758.0 7172.4 7233.1 7239.0 7240.1 7244.9 6885.0 7048.4 7059.6 7062.1 7067.2 7059.6 7139.5 7204.6 7214.7 7245.4 6811.0 6852.4 6856.9 6859.7 6880.6 6701.9 6779.2 6801.7 6803.5 6828.9 7175.9 7176.5 7178.8 7183.1 7187.4 4704.3 4708.6 4710.6 4713.5 4719.7 6770.8 6845.7 6862.9 6866.3 6915.7 6614.4 6621.2 6635.5 6650.0 6664.0 6648.2 6688.7 6689.8 6699.1 6703.4 6447.0 6528.5 6567.3 6584.2 6593.8 6665.3 6708.4 6727.4 6732.3 6741.9 6449.3 6510.6 6555.1 6565.9 6586.0 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - PROCESS | 8427 | [#5] yui.html Cycles:180 Average:13184.75 Median:44320.06 stddev:14842.02 (33.5%) stddev-sans-first:14854.43 22:19:53 INFO - PROCESS | 8427 | Values: 782.4 788.0 838.7 842.1 900.8 13314.9 13318.3 13325.5 13350.2 13476.5 12086.6 12502.3 12505.4 12520.1 12546.0 748.0 756.5 800.9 801.6 806.7 779.5 781.7 788.3 788.3 792.2 819.4 823.2 825.7 825.9 828.3 811.4 811.6 815.3 815.6 819.5 599.2 600.6 602.0 604.4 605.3 13315.0 13347.5 13406.7 13446.7 13513.5 11532.7 11636.0 11731.2 11790.3 11942.7 10278.3 10463.7 10484.0 10506.1 10886.6 3613.4 3632.6 3654.1 3683.9 3726.3 43755.1 43811.1 44033.0 44082.6 44636.0 9629.8 9914.1 9919.0 10052.9 10274.5 16387.5 16413.3 16433.2 16440.8 16448.9 6954.3 7010.5 7039.7 7048.8 7184.0 4118.5 4296.5 4329.2 4341.0 4343.4 3096.8 3106.5 3120.8 3129.1 3138.3 595.5 607.4 609.0 624.0 630.4 622.2 637.4 656.3 657.8 693.8 8958.5 9052.9 9056.8 9067.7 9276.2 588.6 590.0 635.2 648.1 670.2 4017.3 4054.2 4057.6 4168.1 4170.5 50559.2 50852.0 50921.2 50949.7 50995.2 48880.8 48901.3 48996.8 49027.0 49097.8 44543.3 44777.0 44892.0 44907.1 45463.5 8047.3 8126.5 8641.5 8800.4 8824.7 32549.8 33076.2 33088.0 34599.8 34601.0 42493.4 42555.8 42651.8 44004.3 44096.8 10447.8 10725.5 10838.6 10843.6 11189.7 11473.4 11602.7 11666.4 11726.9 12399.4 11458.5 11488.4 11637.9 11921.9 11934.8 11014.1 11195.7 11205.2 11206.2 11526.4 10558.2 11028.0 11142.6 11218.7 11543.5 9023.3 9234.2 9388.6 9433.6 9470.4 8307.0 8907.6 9260.5 9366.0 9373.6 22:19:53 INFO - PROCESS | 8427 | -------- Summary: end -------- 22:19:53 INFO - PROCESS | 8427 | 22:19:53 INFO - TEST-INFO | 8427: exit 0 22:19:53 INFO - TEST-OK | dromaeo_css | took 1111418ms 22:19:53 INFO - TEST-START | kraken 22:19:53 INFO - operating with platform_type : linux_ 22:19:53 INFO - Initialising browser for kraken test... 22:19:53 INFO - TEST-INFO | started process 8670 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGGzaGX/profile http://localhost:33405/getInfo.html) 22:19:57 INFO - PROCESS | 8670 | 22:19:57 INFO - PROCESS | 8670 | (process:8742): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:19:58 INFO - PROCESS | 8670 | __metrics Screen width/height:1600/1200 22:19:58 INFO - PROCESS | 8670 | colorDepth:24 22:19:58 INFO - PROCESS | 8670 | Browser inner width/height: 1024/697 22:19:58 INFO - PROCESS | 8670 | __metrics 22:19:58 INFO - PROCESS | 8670 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:19:59 INFO - TEST-INFO | 8670: exit 0 22:19:59 INFO - Browser initialized. 22:19:59 INFO - Running cycle 1/1 for kraken test... 22:19:59 INFO - TEST-INFO | started process 8791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGGzaGX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:00 INFO - PROCESS | 8791 | 22:20:00 INFO - PROCESS | 8791 | (process:8850): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:11 INFO - PROCESS | 8791 | RSS: Main: 151990272 22:20:11 INFO - PROCESS | 8791 | 22:20:13 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:14 INFO - PROCESS | 8791 | RSS: Main: 156020736 22:20:14 INFO - PROCESS | 8791 | 22:20:16 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-dft) 22:20:17 INFO - PROCESS | 8791 | RSS: Main: 158892032 22:20:17 INFO - PROCESS | 8791 | 22:20:20 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-fft) 22:20:20 INFO - PROCESS | 8791 | RSS: Main: 153346048 22:20:20 INFO - PROCESS | 8791 | 22:20:23 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33405/tests/kraken/driver.html?testName=audio-oscillator) 22:20:23 INFO - PROCESS | 8791 | RSS: Main: 153214976 22:20:23 INFO - PROCESS | 8791 | 22:20:26 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:26 INFO - PROCESS | 8791 | RSS: Main: 152678400 22:20:26 INFO - PROCESS | 8791 | 22:20:29 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:30 INFO - PROCESS | 8791 | RSS: Main: 153149440 22:20:30 INFO - PROCESS | 8791 | 22:20:33 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33405/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:34 INFO - PROCESS | 8791 | RSS: Main: 154644480 22:20:34 INFO - PROCESS | 8791 | 22:20:37 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33405/tests/kraken/driver.html?testName=json-parse-financial) 22:20:37 INFO - PROCESS | 8791 | RSS: Main: 153006080 22:20:37 INFO - PROCESS | 8791 | 22:20:39 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:39 INFO - PROCESS | 8791 | RSS: Main: 154144768 22:20:39 INFO - PROCESS | 8791 | 22:20:41 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:42 INFO - PROCESS | 8791 | RSS: Main: 153772032 22:20:42 INFO - PROCESS | 8791 | 22:20:44 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:44 INFO - PROCESS | 8791 | RSS: Main: 153907200 22:20:44 INFO - PROCESS | 8791 | 22:20:47 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:47 INFO - PROCESS | 8791 | RSS: Main: 154533888 22:20:47 INFO - PROCESS | 8791 | 22:20:50 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:51 INFO - PROCESS | 8791 | RSS: Main: 154128384 22:20:51 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | Cycle 1(1): loaded http://localhost:33405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33405/tests/kraken/driver.html?testName=ai-astar) 22:20:52 INFO - PROCESS | 8791 | RSS: Main: 154120192 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | __start_tp_report 22:20:52 INFO - PROCESS | 8791 | _x_x_mozilla_page_load 22:20:52 INFO - PROCESS | 8791 | _x_x_mozilla_page_load_details 22:20:52 INFO - PROCESS | 8791 | |i|pagename|runs| 22:20:52 INFO - PROCESS | 8791 | |0;ai-astar;112;106;111;112;111;123;109;111;110;112 22:20:52 INFO - PROCESS | 8791 | |1;audio-beat-detection;153;128;157;166;131;162;156;136;164;133 22:20:52 INFO - PROCESS | 8791 | |2;audio-dft;162;162;163;165;162;163;164;168;165;163 22:20:52 INFO - PROCESS | 8791 | |3;audio-fft;73;73;73;72;74;148;77;73;98;73 22:20:52 INFO - PROCESS | 8791 | |4;audio-oscillator;97;97;151;96;96;97;141;97;96;138 22:20:52 INFO - PROCESS | 8791 | |5;imaging-gaussian-blur;110;110;111;109;110;109;110;110;110;110 22:20:52 INFO - PROCESS | 8791 | |6;imaging-darkroom;147;146;147;146;148;147;146;146;147;148 22:20:52 INFO - PROCESS | 8791 | |7;imaging-desaturate;97;97;97;99;97;97;97;97;96;96 22:20:52 INFO - PROCESS | 8791 | |8;json-parse-financial;60;59;59;59;59;64;61;61;67;58 22:20:52 INFO - PROCESS | 8791 | |9;json-stringify-tinderbox;67;69;71;68;70;69;68;68;68;68 22:20:52 INFO - PROCESS | 8791 | |10;stanford-crypto-aes;82;80;82;90;83;82;83;83;84;84 22:20:52 INFO - PROCESS | 8791 | |11;stanford-crypto-ccm;121;124;122;116;126;117;121;123;116;125 22:20:52 INFO - PROCESS | 8791 | |12;stanford-crypto-pbkdf2;139;156;139;146;157;133;146;143;143;131 22:20:52 INFO - PROCESS | 8791 | |13;stanford-crypto-sha256-iterative;67;69;70;68;69;66;68;74;66;66 22:20:52 INFO - PROCESS | 8791 | __end_tp_report 22:20:52 INFO - PROCESS | 8791 | __start_cc_report 22:20:52 INFO - PROCESS | 8791 | _x_x_mozilla_cycle_collect,744 22:20:52 INFO - PROCESS | 8791 | __end_cc_report 22:20:52 INFO - PROCESS | 8791 | __startTimestamp1453616452979__endTimestamp 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | ------- Summary: start ------- 22:20:52 INFO - PROCESS | 8791 | Number of tests: 14 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.50 stddev:4.37 (3.9%) stddev-sans-first:4.64 22:20:52 INFO - PROCESS | 8791 | Values: 112.0 106.0 111.0 112.0 111.0 123.0 109.0 111.0 110.0 112.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.50 stddev:14.91 (9.5%) stddev-sans-first:15.73 22:20:52 INFO - PROCESS | 8791 | Values: 153.0 128.0 157.0 166.0 131.0 162.0 156.0 136.0 164.0 133.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.89 (1.2%) stddev-sans-first:1.90 22:20:52 INFO - PROCESS | 8791 | Values: 162.0 162.0 163.0 165.0 162.0 163.0 164.0 168.0 165.0 163.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#3] audio-fft Cycles:10 Average:83.40 Median:73.00 stddev:24.01 (32.9%) stddev-sans-first:25.17 22:20:52 INFO - PROCESS | 8791 | Values: 73.0 73.0 73.0 72.0 74.0 148.0 77.0 73.0 98.0 73.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:22.82 (23.6%) stddev-sans-first:23.67 22:20:52 INFO - PROCESS | 8791 | Values: 97.0 97.0 151.0 96.0 96.0 97.0 141.0 97.0 96.0 138.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:20:52 INFO - PROCESS | 8791 | Values: 110.0 110.0 111.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:20:52 INFO - PROCESS | 8791 | Values: 147.0 146.0 147.0 146.0 148.0 147.0 146.0 146.0 147.0 148.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 22:20:52 INFO - PROCESS | 8791 | Values: 97.0 97.0 97.0 99.0 97.0 97.0 97.0 97.0 96.0 96.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:60.50 stddev:2.79 (4.6%) stddev-sans-first:2.95 22:20:52 INFO - PROCESS | 8791 | Values: 60.0 59.0 59.0 59.0 59.0 64.0 61.0 61.0 67.0 58.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:1.09 22:20:52 INFO - PROCESS | 8791 | Values: 67.0 69.0 71.0 68.0 70.0 69.0 68.0 68.0 68.0 68.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.63 (3.2%) stddev-sans-first:2.74 22:20:52 INFO - PROCESS | 8791 | Values: 82.0 80.0 82.0 90.0 83.0 82.0 83.0 83.0 84.0 84.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:122.50 stddev:3.67 (3.0%) stddev-sans-first:3.89 22:20:52 INFO - PROCESS | 8791 | Values: 121.0 124.0 122.0 116.0 126.0 117.0 121.0 123.0 116.0 125.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:144.50 stddev:8.55 (5.9%) stddev-sans-first:8.93 22:20:52 INFO - PROCESS | 8791 | Values: 139.0 156.0 139.0 146.0 157.0 133.0 146.0 143.0 143.0 131.0 22:20:52 INFO - PROCESS | 8791 | 22:20:52 INFO - PROCESS | 8791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:2.45 (3.6%) stddev-sans-first:2.55 22:20:52 INFO - PROCESS | 8791 | Values: 67.0 69.0 70.0 68.0 69.0 66.0 68.0 74.0 66.0 66.0 22:20:52 INFO - PROCESS | 8791 | -------- Summary: end -------- 22:20:52 INFO - PROCESS | 8791 | 22:20:53 INFO - TEST-INFO | 8791: exit 0 22:20:53 INFO - TEST-OK | kraken | took 60190ms 22:20:53 INFO - TEST-START | v8_7 22:20:53 INFO - operating with platform_type : linux_ 22:20:53 INFO - Initialising browser for v8_7 test... 22:20:53 INFO - TEST-INFO | started process 9079 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2s_EE/profile http://localhost:33405/getInfo.html) 22:20:57 INFO - PROCESS | 9079 | 22:20:57 INFO - PROCESS | 9079 | (process:9148): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:20:58 INFO - PROCESS | 9079 | __metrics Screen width/height:1600/1200 22:20:58 INFO - PROCESS | 9079 | colorDepth:24 22:20:58 INFO - PROCESS | 9079 | Browser inner width/height: 1024/697 22:20:58 INFO - PROCESS | 9079 | __metrics 22:20:58 INFO - PROCESS | 9079 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:20:59 INFO - TEST-INFO | 9079: exit 0 22:20:59 INFO - Browser initialized. 22:20:59 INFO - Running cycle 1/1 for v8_7 test... 22:20:59 INFO - TEST-INFO | started process 9197 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2s_EE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:21:00 INFO - PROCESS | 9197 | 22:21:00 INFO - PROCESS | 9197 | (process:9256): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:21:11 INFO - PROCESS | 9197 | RSS: Main: 151703552 22:21:11 INFO - PROCESS | 9197 | 22:21:33 INFO - PROCESS | 9197 | Cycle 1(1): loaded http://localhost:33405/tests/v8_7/run.html (next: http://localhost:33405/tests/v8_7/run.html) 22:21:34 INFO - PROCESS | 9197 | RSS: Main: 151228416 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | __start_tp_report 22:21:34 INFO - PROCESS | 9197 | _x_x_mozilla_page_load 22:21:34 INFO - PROCESS | 9197 | _x_x_mozilla_page_load_details 22:21:34 INFO - PROCESS | 9197 | |i|pagename|runs| 22:21:34 INFO - PROCESS | 9197 | |0;Richards;167.36401673640168 22:21:34 INFO - PROCESS | 9197 | |1;DeltaBlue;190.1863826550019 22:21:34 INFO - PROCESS | 9197 | |2;Encrypt;280.0336040324839 22:21:34 INFO - PROCESS | 9197 | |3;Decrypt;5208.333333333333 22:21:34 INFO - PROCESS | 9197 | |4;RayTrace;1057.0824524312895 22:21:34 INFO - PROCESS | 9197 | |5;Earley;714.2857142857143 22:21:34 INFO - PROCESS | 9197 | |6;Boyer;12537.5 22:21:34 INFO - PROCESS | 9197 | |7;RegExp;42244.897959183676 22:21:34 INFO - PROCESS | 9197 | |8;Splay;643.915003219575 22:21:34 INFO - PROCESS | 9197 | |9;NavierStokes;4835.748792270531 22:21:34 INFO - PROCESS | 9197 | __end_tp_report 22:21:34 INFO - PROCESS | 9197 | __startTimestamp1453616494016__endTimestamp 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | ------- Summary: start ------- 22:21:34 INFO - PROCESS | 9197 | Number of tests: 10 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#0] Richards Cycles:1 Average:167.36 Median:167.36 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 167.4 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#1] DeltaBlue Cycles:1 Average:190.19 Median:190.19 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 190.2 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#2] Encrypt Cycles:1 Average:280.03 Median:280.03 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 280.0 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 5208.3 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#4] RayTrace Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 1057.1 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#5] Earley Cycles:1 Average:714.29 Median:714.29 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 714.3 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#6] Boyer Cycles:1 Average:12537.50 Median:12537.50 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 12537.5 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#7] RegExp Cycles:1 Average:42244.90 Median:42244.90 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 42244.9 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#8] Splay Cycles:1 Average:643.92 Median:643.92 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 643.9 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - PROCESS | 9197 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 22:21:34 INFO - PROCESS | 9197 | Values: 4835.7 22:21:34 INFO - PROCESS | 9197 | -------- Summary: end -------- 22:21:34 INFO - PROCESS | 9197 | 22:21:34 INFO - TEST-INFO | 9197: exit 0 22:21:34 INFO - TEST-OK | v8_7 | took 41003ms 22:21:34 INFO - SUITE-END | took 1212s 22:21:34 INFO - Completed test suite (00:20:12) 22:21:34 INFO - Working with test: dromaeo_css 22:21:34 INFO - Generating results file: dromaeo_css 22:21:34 INFO - Working with test: kraken 22:21:34 INFO - Generating results file: kraken 22:21:34 INFO - javascript benchmark 22:21:34 INFO - Working with test: v8_7 22:21:34 INFO - Generating results file: v8_7 22:21:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:21:35 INFO - process_Request line: dromaeo_css 6883.55 graph.html#tests=[[72,1,43]] 22:21:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:35 INFO - process_Request line: kraken 1517.00 graph.html#tests=[[232,1,43]] 22:21:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:21:35 INFO - process_Request line: v8_7 20135.63 graph.html#tests=[[230,1,43]] 22:21:35 INFO - RETURN: dromaeo_css: 6883.55 22:21:35 INFO - RETURN: kraken: 1517.00 22:21:35 INFO - RETURN: v8_7: 20135.63 22:21:35 INFO - javascript benchmark 22:21:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3234.741220702344, 3242.432574299497, 3262.5921759780026, 3288.2272665923497, 3296.8681252749893, 5223.347081614798, 5350.0904846176145, 5365.91951120733, 5385.003774301752, 5387.568994480442, 5251.684898906059, 5271.710055946922, 5303.840884773454, 5314.707691076989, 5335.093034184189, 4797.448293446263, 4824.059308434857, 4859.2225243960975, 4910.75446227689, 4950.925736113961, 764.8049196688946, 4774.594159496447, 4781.139394908915, 4865.708057516543, 4889.26661000851, 4832.830850920236, 4862.270659401082, 4877.46347901734, 4884.267359896008, 4892.119418504668, 4886.389201349832, 4912.410510738699, 4997.600191984632, 5027.572656324217, 5029.723365214912, 4746.43042834862, 4760.285957106427, 4823.348847905523, 4842.467328593887, 4995.550400463976, 5118.4625614310335, 5125.410577783566, 5141.948580514184, 5154.639175257734, 5207.244949482304, 5647.040003199466, 5666.178404131378, 5678.205051292823, 5680.46035626619, 5698.31620205578, 5598.832035038955, 5626.9437305626825, 5753.482186603226, 5775.5957083004205, 5790.13148027795, 5418.891622167574, 5453.727313634303, 5455.454454554552, 5455.8363249102595, 5466.6993315367245, 5820.156077368758, 5940.0, 5947.9702601486715, 5951.940480595225, 5966.701664916737, 5578.358488773762, 5643.294588176478, 5670.376258611549, 5686.317641882918, 5737.655740655574, 5845.853853653693, 5850.3564607893095, 5881.117832325185, 5894.115882617642, 5895.793647222326, 5537.889242215133, 5786.218860453785, 5835.591508594358, 5868.853278667982, 5871.089981052944, 5494.2857428534835, 5503.862403439866, 5522.3649280333275, 5549.139883318092, 5549.19536667181, 4414.646828253732, 4424.557544245614, 4430.579094985971, 4454.7549884756645, 4459.264221403432, 3958.990457433336, 3965.8810235692977, 3978.661813745864, 3999.2601368746873, 4045.1707399982934, 5174.0, 5183.118869792144, 5267.762950667229, 5418.133098704188, 5477.397486276506, 5610.158476228598, 5648.8870222595315, 5696.943030569724, 5740.569457290637, 5784.248047753849, 5362.088444964365, 5366.704831234241, 5384.5692344612335, 5398.91901621476, 5399.217113518518, 4812.735299558488, 4893.996730670276, 4901.044296362246, 4916.041371932511, 4959.801607935714, 5865.589408741347, 5931.0, 5999.1901093351835, 6009.759609615567, 6050.9394906050375, 5746.511546518593, 5754.625949313281, 5757.4242575743765, 5760.855978600401, 5767.625104368202, 5739.339975902824, 5876.764929402947, 5902.350741418355, 5935.584509084322, 5950.315713692808, 5647.6893770843, 5700.458456446631, 5708.771649133988, 5715.799947001835, 5759.596828221985, 5711.48596626289, 5749.453801888814, 5752.827415177551, 5756.740946657326, 5779.884402312015, 5492.340919089735, 5550.361708403424, 5580.497755202051, 5598.468145526169, 5642.379338272869, 5613.494785469164, 5630.831075067755, 5634.7464364104535, 5649.915251271152, 5690.829275121753, 5508.724563771875, 5515.889682206413, 5529.585281103853, 5530.308711411074, 5534.446555344433, 5473.67157970523, 5556.499915007507, 5605.5795815313195, 5623.915641265467, 5639.182318563703, 5562.721863906708, 5564.10974244119, 5578.246936663499, 5619.9719001406365, 5623.943760562342], "unit": "score", "name": "dojo.html", "value": 5257.983596816393}, {"lowerIsBetter": false, "replicates": [531.9840404787856, 540.8053100883683, 549.1460778489447, 560.2156980227679, 570.3441042800779, 38360.23279534411, 38950.22099558007, 38987.610123898754, 39009.41485877707, 39026.60973390265, 42089.0, 42379.78810105953, 42397.78801105998, 42785.57214427855, 42821.14357712852, 8522.957385213065, 8689.478631282143, 8775.692850750225, 8779.34154938379, 8802.955985220096, 8441.95779021107, 8575.056743758181, 8627.43921645091, 8658.307335413152, 8661.3937024408, 8599.312055035582, 8715.694950676727, 8724.389292749478, 8737.21365077143, 8770.6930257441, 8581.356398270123, 8622.784430389227, 8700.129987001312, 8703.782405439882, 8714.520701361422, 8502.277306428961, 8566.657333706644, 8594.0, 8659.307255419551, 8674.04585495595, 39126.0, 39349.21301573981, 39355.80322098371, 39380.21239575221, 39552.60447395518, 3187.5218717192374, 3237.546743455918, 3318.2699806042633, 3368.6631336866117, 3688.778673279585, 29608.55587166194, 30168.0, 30371.544426833614, 30705.38589228225, 31511.897083601965, 4083.367078102869, 4084.4485994390675, 4100.118474527991, 4117.300058989949, 4126.896827579305, 262037.0, 262661.9999999981, 263839.0, 265113.0, 266639.0, 52058.21912671313, 52984.20523692148, 59099.40900590939, 59379.0, 59408.10887836686, 53661.46338536565, 53748.46251537435, 54025.189622155696, 54170.0, 54200.45799541954, 13797.793033104512, 13954.372053257628, 13957.581272561636, 14012.649683757987, 14051.156930584199, 10698.73253168677, 10724.517396717167, 10725.946370268099, 10765.730856728644, 10785.89214107849, 19292.1318540666, 19504.344706632855, 20383.388498344775, 20426.38720838377, 20464.488387790425, 7928.0, 8016.038075430985, 8063.556504392197, 8073.878891816627, 8092.878606820902, 918.150710592699, 982.8427451607708, 993.5529011944653, 1033.03927347566, 1052.4264275969463, 25240.621390679156, 29223.56164657532, 29269.707302927123, 29311.85344073266, 29723.85138074296, 1012.8227560177087, 1030.9742256443649, 1039.262123892045, 1118.7874303882236, 1134.8694900086596, 15113.16877571744, 15212.174539055162, 15517.146556939477, 16310.0, 17362.39231626887, 383069.0, 384617.0, 384734.0, 386147.0, 386716.0, 55581.0, 55589.444105558425, 56076.43923560712, 56200.15699764507, 56240.71879640576, 1343.6909510812568, 1347.3398034962797, 1358.8233529641282, 1367.43934986655, 1370.766969615148, 29621.851890740407, 30246.30443666924, 30646.233844153183, 30712.385752285278, 30833.383332332778, 46261.0, 46416.535834641225, 46676.53323466722, 46972.7651361741, 47238.29142562933, 307522.0, 309919.0, 310529.0, 310770.0, 311802.0, 30571.0, 42903.35644965265, 43578.34632480452, 43944.34083488814, 44150.55849441593, 41003.0, 42818.0, 43091.138177236906, 43493.34759978666, 43759.0, 35598.28803423969, 35957.64042359543, 35971.0, 36425.08937276589, 37229.81385093057, 36033.27933441264, 36940.44589331216, 37154.0, 37433.0, 37471.0, 34781.0, 34912.0, 35457.0, 35485.64514354823, 35494.822525887204, 30968.380632387678, 31498.582563784228, 33327.33345333128, 33342.833285834386, 33522.66477335196, 25141.24576262715, 25168.74831251664, 25432.74567254304, 25635.743642563335, 25671.486570268116], "unit": "score", "name": "ext.html", "value": 18697.503080134506}, {"lowerIsBetter": false, "replicates": [365.8975486863678, 368.3130960758185, 368.86167687117324, 371.67849809914435, 372.50642898159913, 16033.358665653375, 16433.342666293334, 16997.0, 17042.48872533826, 17877.55306117346, 10833.404162771065, 10965.067969222626, 16023.759643605326, 16245.106519141442, 16401.753973690404, 4899.0446862861845, 5081.390233172025, 5192.091384007803, 5282.709450980195, 5295.735213239342, 5172.482751724835, 5304.257403963448, 5314.973425132869, 5374.086405311106, 5401.864953376158, 5090.974545127269, 5289.841304760844, 5319.627626066177, 5364.785408583652, 5392.0294347017525, 5222.112240919015, 5231.267622532849, 5255.395629502618, 5259.421463638997, 5599.63602365849, 5318.069337865858, 5346.946530534723, 5359.062164121302, 5360.035193665139, 5367.865803354908, 12856.0, 12941.935290323489, 12998.740025199442, 13001.219926804328, 17688.76178667494, 2046.7850875657991, 2162.426956856434, 2171.3051823416513, 2189.8576592521595, 2293.121629956823, 9096.181343679034, 9204.585793639302, 9243.0, 9261.583228754722, 9487.430754154704, 1745.1099939031185, 1765.143905205974, 1789.3826629812693, 1815.0289595066708, 1841.0702595189343, 50517.74741126307, 50826.7458662708, 52668.736656316854, 52846.0, 53135.20297195545, 9814.116729494379, 9949.900500995042, 10026.248031397674, 10094.09153176203, 10152.086312231786, 13175.67060823487, 13188.340582970814, 13198.934005330104, 13234.73530529384, 13260.668483287995, 7104.502684812117, 7178.2103968563415, 7179.641017949186, 7187.281271872771, 7234.348908598146, 6771.864562708817, 6986.860262794716, 6998.125234345707, 7059.082319298561, 7117.786466406016, 4361.781910904442, 4460.219461594208, 4460.50934397216, 4482.148391805546, 4483.529229430928, 1706.8037175724703, 1806.7741532308462, 1846.7322238275374, 1848.1775609853755, 1863.5900101977543, 852.3820230333083, 915.3729695158704, 922.1930810540777, 924.3483344242427, 1000.214831357381, 15227.619309517351, 15639.68720625604, 15761.369545218293, 16288.755668664979, 16354.509364718839, 856.9914300857037, 915.8443064678887, 941.1576638908276, 960.5677445149711, 981.7588610410825, 8832.116788321246, 8843.380963332505, 8912.970807326275, 8921.687740929035, 9172.908270917205, 527186.0, 527448.0, 531375.0, 549675.0, 565751.0, 42755.78622106932, 43134.35298470463, 43395.56604433915, 67165.0, 67793.0, 1130.2935665209245, 1142.2461175624048, 1143.4225716013527, 1152.4180288954024, 1154.249737670521, 13410.32948352598, 13517.932410337886, 13532.188068715908, 13602.38789254466, 13771.655708607364, 28102.156935291972, 28994.275143120747, 29297.560536591543, 29955.365845124667, 29986.95045673391, 40980.38529422002, 40986.79506602448, 41132.58867411407, 41377.37933931054, 41443.7927810359, 6990.497043135751, 7011.439084873095, 7184.173820010766, 7200.71197152129, 7248.275172482709, 8288.917110829056, 10251.53963048848, 10406.635767748092, 10604.363738175734, 10703.518341674799, 8788.472691638523, 9323.440593564408, 9378.624855005723, 9381.718548443558, 9561.952190239283, 9600.519974001132, 9688.224942004763, 9730.659426920023, 9759.0, 10019.949900250453, 9532.714018579454, 9760.609575616896, 9811.362261452983, 9884.209263259067, 9909.256805739455, 7281.453890958305, 7460.104787425544, 7558.433117516318, 7575.886361704469, 7583.127940286938, 9163.77090572741, 9694.22446204288, 9810.104477462959, 9875.901240987498, 9939.652112176329], "unit": "score", "name": "jquery.html", "value": 7833.526534758097}, {"lowerIsBetter": false, "replicates": [1413.6183230527758, 1430.8497607751185, 1557.5638821130087, 1735.366591194213, 1755.7103077992124, 7531.924680753191, 7552.622368881562, 7790.8441831163345, 7800.609969501531, 7850.76447706569, 7642.503237289572, 7746.419018573615, 7749.418793590489, 7799.220077992198, 7801.492902961303, 2326.4765427778743, 2359.988200059006, 2369.312899259213, 2376.4652953085506, 2384.76152384761, 2357.457784709518, 2369.7037870266217, 2381.7022872140983, 2384.606539920911, 2388.4984153327823, 2201.7688142745023, 2268.421552504109, 2272.068451934707, 2273.102124660758, 2286.622707253301, 2310.803581695558, 2322.477442575407, 2336.1356298169703, 2345.2495201535517, 2346.683197768305, 2327.185485080225, 2344.167820423759, 2345.1909091363455, 2349.189529612281, 2354.599718047919, 7880.605969701492, 7917.089534703525, 7952.443328966975, 7976.242256985577, 7981.640826162837, 4797.736124513151, 4843.9515604843855, 4908.558229759339, 4925.21196608541, 4928.1129396708575, 3067.6165479315086, 3168.461361568539, 3186.4423725848114, 3201.439748044106, 3231.2406584452633, 1094.934303941766, 1108.6396921000708, 1110.9611163609316, 1142.520141540555, 1178.6346232667815, 10714.9464252679, 10804.72988175294, 10810.189235807346, 10823.945880270549, 10843.457827108692, 4104.91790164195, 4285.871423857289, 4306.956930430718, 4307.181635489247, 4320.0, 8706.216440520384, 8718.520481373458, 8741.519216443157, 8753.431026983226, 8771.736847894574, 4755.619550435957, 4805.903881922342, 4807.519248075165, 4815.22956326986, 4841.685290456109, 4398.516163222043, 4403.471583409947, 4404.66964977628, 4408.184485870124, 4464.308032255006, 3489.8778542750883, 3524.101354154674, 3531.1878267998504, 3568.553930758655, 3572.5712914449914, 1062.2988827373897, 1100.9339439633648, 1108.6673997800629, 1111.6053800900563, 1120.0815331428314, 862.7066797288952, 1053.031211285619, 1096.4956120184645, 1111.8776934537195, 1264.9683757906125, 7280.6723697433745, 7305.598192099379, 7326.377257933135, 7340.009098771704, 7349.742759003409, 1128.1024061866397, 1178.1693905796392, 1185.911056670736, 1195.665213740154, 1206.5234232478297, 5647.943520564824, 5656.547476201894, 5687.43125687428, 5729.0, 5761.88476230473, 8974.28205743539, 9223.216026637676, 9264.861027084598, 9307.953460232655, 9338.299627527962, 9124.771880703036, 9191.402558833788, 9197.218236449977, 9228.769280768034, 9306.86039709405, 7236.34872861445, 7358.668859901317, 7374.520656157332, 7407.740729074349, 7419.85160296791, 6982.371586557234, 6984.3364880336285, 7011.26381729911, 7026.402755765613, 7072.83298255782, 8259.463134896212, 8366.954130733659, 8394.706185283485, 8401.663933442594, 8431.704890328809, 8503.489790612583, 8513.489190648581, 8519.574021298786, 8601.784955376166, 8617.65529378843, 6620.933790662224, 6706.061151438705, 6722.865542689216, 6723.798286051427, 6728.091707619409, 7531.774046778605, 7537.736179233701, 7538.849223015399, 7592.278733520307, 7594.8860767087435, 6365.2361716594305, 6857.5199736018, 7126.358627723323, 7148.356647901714, 7245.094363204599, 6330.335314792064, 6498.707558159988, 6788.083608712761, 6871.690773915086, 6890.20762612306, 6655.134832471747, 6701.564398314094, 6760.628165450948, 6777.864442711217, 6783.626900520519, 6233.875322493615, 6288.151099601495, 6299.275583307795, 6310.0, 6312.116303717575, 6389.7763578274535, 6399.840003999937, 6403.647799370893, 6423.935760642521, 6442.774502892376], "unit": "score", "name": "mootools.html", "value": 4497.202676968741}, {"lowerIsBetter": false, "replicates": [340.77508844162855, 343.5962743776064, 346.59275351462026, 349.9685028347449, 350.9017475106969, 6156.0, 6216.720247588858, 6239.438450539451, 6270.372962703727, 6399.232092148949, 6181.6600086995195, 6203.131561581382, 6215.59598626089, 6224.906626400608, 6251.968740156304, 4656.44122705275, 4736.076465089309, 4738.4313882334, 4741.90516189676, 4742.05158968206, 4689.296605509184, 4689.57793798558, 4717.033008233304, 4753.595944344735, 4756.571908528232, 4590.127875703605, 4622.097614910761, 4644.140833945714, 4685.83599574015, 4723.220668589679, 4675.345451636774, 4681.929771053454, 4683.227267500858, 4689.531046895318, 4691.319758635013, 4077.3476243801147, 4083.97958010211, 4097.569755175723, 4104.979475102636, 4111.876643700693, 5801.593888427812, 5802.622829516068, 5819.24349834523, 5836.445537673914, 5846.736896839652, 5387.892242155174, 5454.34547854256, 5463.699496527689, 5502.064649009638, 5510.531604813596, 6509.707063182121, 6521.184851893513, 6522.054302126166, 6526.869462610721, 6547.116139321179, 4532.4334458192725, 4564.612007979325, 4569.634429245652, 4574.19951508488, 4575.748333841638, 6656.267810540789, 6754.729810807562, 6766.729330826761, 6798.422134118606, 6821.4542836572955, 4637.281221410687, 4665.113628410591, 4667.8599642010795, 4671.766411679402, 4676.3686902267755, 4687.554682305175, 4716.528347165256, 4720.0559888022535, 4720.701807003102, 4720.716756994591, 5454.400015998237, 5466.945330546644, 5467.535259502987, 5471.945280547144, 5475.370332411744, 6465.353464653591, 6545.443637290884, 6597.30728273534, 6632.668366581652, 6644.435223006002, 1658.1874881308072, 1681.1090122235235, 1681.6720739455689, 1685.5112017515028, 1685.8145603983553, 1097.928634638746, 1101.30067407197, 1117.3184357541893, 1117.502711293483, 1119.2892513254142, 6219.40915613016, 6226.657533835682, 6254.999200128049, 6256.874862502816, 6268.686565671698, 6809.080774095532, 6809.182898052166, 6815.386615204656, 6820.658967051628, 6839.213490448563, 5953.464188222994, 6032.155498230251, 6151.630902145886, 6175.5677102602385, 6202.0, 3679.889603311905, 3704.81475926208, 3707.480952666629, 3744.9625503744614, 3758.0229140423685, 7172.354488096096, 7233.095863017123, 7238.963805180941, 7240.094988126484, 7244.855102897913, 6885.001674757233, 7048.436125109979, 7059.5764254144915, 7062.081929349151, 7067.151941767021, 7059.576425414389, 7139.535930164523, 7204.639768011683, 7214.74748383804, 7245.38414234796, 6811.012403201607, 6852.383285504328, 6856.897146542706, 6859.691313890987, 6880.621565813928, 6701.932980670326, 6779.220389655253, 6801.727930882709, 6803.489738269748, 6828.897566536605, 7175.928240717526, 7176.461765367514, 7178.784636460915, 7183.066201393785, 7187.425005999612, 4704.317873908332, 4708.6468514860835, 4710.552497512731, 4713.505081966481, 4719.69321994083, 6770.796876093725, 6845.691943862438, 6862.897056544256, 6866.34769696878, 6915.654217289216, 6614.437772789367, 6621.205455345389, 6635.502337324623, 6650.0, 6663.966680166568, 6648.202215734143, 6688.7324507019175, 6689.832754181184, 6699.062131301719, 6703.396694297537, 6447.0, 6528.510361722795, 6567.310432404529, 6584.242812076673, 6593.835154121185, 6665.333466653296, 6708.396244338033, 6727.394534491919, 6732.259451460433, 6741.865162696817, 6449.258335291502, 6510.609363438209, 6555.147830781968, 6565.934340656532, 6585.96707016481], "unit": "score", "name": "prototype.html", "value": 4976.136278817007}, {"lowerIsBetter": false, "replicates": [782.3936449251829, 788.0385929166415, 838.6645341863253, 842.1073661918371, 900.7838118851475, 13314.93342533286, 13318.267495287755, 13325.46698132076, 13350.1989880607, 13476.52832150875, 12086.637400877966, 12502.312372819491, 12505.374731263446, 12520.123591348609, 12546.0, 747.9813004674872, 756.5422919133928, 800.8838718385831, 801.6432687454085, 806.7176488229131, 779.4504874063772, 781.6834182156235, 788.2511613966726, 788.333857890082, 792.18405042806, 819.3772732723114, 823.1768231768232, 825.6821123867294, 825.8926339575846, 828.3000864269683, 811.350919264586, 811.6347643560392, 815.3110621524802, 815.6166601697253, 819.4919150126959, 599.2449513612836, 600.642617642502, 602.0457574744036, 604.4348534120611, 605.33110912442, 13315.0, 13347.532836350681, 13406.664833379145, 13446.731065378637, 13513.459461621524, 11532.711682207928, 11636.0, 11731.17881748278, 11790.292582445081, 11942.701432464171, 10278.33190842593, 10463.738406539822, 10484.0, 10506.106980906632, 10886.564537418493, 3613.385724426854, 3632.5640923089136, 3654.104744337628, 3683.9447408288897, 3726.347889119393, 43755.12489750219, 43811.12377752459, 44033.0, 44082.55917440817, 44635.99999999967, 9629.807403851884, 9914.107730304308, 9918.950405248072, 10052.894181640013, 10274.537645805807, 16387.508374748777, 16413.343466261456, 16433.178341082898, 16440.83559164417, 16448.917755411145, 6954.269801670853, 7010.509264351548, 7039.683214255371, 7048.788536343918, 7183.994240806292, 4118.5057793064425, 4296.5273819879785, 4329.177456283296, 4341.0, 4343.391925130484, 3096.752259819209, 3106.5340198970334, 3120.812751234888, 3129.108204161803, 3138.2938838761097, 595.5354823237882, 607.3986753114473, 608.996955015222, 623.9500839932795, 630.4294613374904, 622.1538707357989, 637.4231320654815, 656.2584279763931, 657.8223879552589, 693.8022663540867, 8958.507282099417, 9052.909470905339, 9056.773580660536, 9067.727968160965, 9276.165145136834, 588.6056342250703, 590.0, 635.1742734445203, 648.1120864415686, 670.2191946382508, 4017.337139371971, 4054.2296963576828, 4057.634812866856, 4168.103857670615, 4170.4995400551525, 50559.24161137586, 50852.0, 50921.23618145731, 50949.745251274246, 50995.23507147396, 48880.7555962225, 48901.266481002815, 48996.75501622469, 49027.0, 49097.75451122793, 44543.331850022274, 44777.0, 44892.0, 44907.101857962654, 45463.54536454659, 8047.315978141924, 8126.512409255463, 8641.481511109354, 8800.427972181787, 8824.691135810215, 32549.837250813594, 33076.1730956728, 33088.0, 34599.82700086483, 34600.9619711409, 42493.362599560416, 42555.78722106494, 42651.7867410661, 44004.33993490036, 44096.779516102215, 10447.843282350923, 10725.517351719347, 10838.566457341618, 10843.620473283398, 11189.72025699364, 11473.426328683365, 11602.70993225176, 11666.416679166177, 11726.94136529312, 12399.380030998595, 11458.541658333574, 11488.425578721197, 11637.88362116402, 11921.880781192078, 11934.761304774029, 11014.118870490182, 11195.664130076111, 11205.215634905479, 11206.215564910379, 11526.423678816192, 10558.212768485919, 11028.0, 11142.610008649659, 11218.719532011764, 11543.538258469904, 9023.278137749096, 9234.1689247968, 9388.624455021996, 9433.622655093994, 9470.431774093577, 8306.958465207636, 8907.599158037774, 9260.53697315118, 9366.0, 9373.62338208737], "unit": "score", "name": "yui.html", "value": 6172.268464913124}], "name": "dromaeo_css", "value": 6883.554697340728}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 112.0, 111.0, 123.0, 109.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [153.0, 128.0, 157.0, 166.0, 131.0, 162.0, 156.0, 136.0, 164.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 165.0, 162.0, 163.0, 164.0, 168.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 74.0, 148.0, 77.0, 73.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 151.0, 96.0, 96.0, 97.0, 141.0, 97.0, 96.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 99.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 64.0, 61.0, 61.0, 67.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 71.0, 68.0, 70.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 82.0, 90.0, 83.0, 82.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 122.0, 116.0, 126.0, 117.0, 121.0, 123.0, 116.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [139.0, 156.0, 139.0, 146.0, 157.0, 133.0, 146.0, 143.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 70.0, 68.0, 69.0, 66.0, 68.0, 74.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1516.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.36401673640168], "unit": "score", "name": "Richards", "value": 210.92945000000006}, {"lowerIsBetter": false, "replicates": [190.1863826550019], "unit": "score", "name": "DeltaBlue", "value": 347.648444}, {"lowerIsBetter": false, "replicates": [280.0336040324839], "unit": "score", "name": "Encrypt", "value": 950.5323509999997}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1057.0824524312895], "unit": "score", "name": "RayTrace", "value": 700.0295939999999}, {"lowerIsBetter": false, "replicates": [714.2857142857143], "unit": "score", "name": "Earley", "value": 933.0482000000002}, {"lowerIsBetter": false, "replicates": [12537.5], "unit": "score", "name": "Boyer", "value": 53.15756729810566}, {"lowerIsBetter": false, "replicates": [42244.897959183676], "unit": "score", "name": "RegExp", "value": 21.564379227053134}, {"lowerIsBetter": false, "replicates": [643.915003219575], "unit": "score", "name": "Splay", "value": 126.55552300000004}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20135.629098394365}]} 22:21:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "20135.63"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1517.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6883.55"}}} 22:21:35 INFO - Return code: 0 22:21:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:21:35 INFO - # TBPL SUCCESS # 22:21:35 INFO - Running post-action listener: _resource_record_post_action 22:21:35 INFO - Running post-run listener: _resource_record_post_run 22:21:36 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 549543936; Read time: 0; Write time: 406432 22:21:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236429312; Read time: 0; Write time: 219684 22:21:36 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 313114624; Read time: 0; Write time: 186748 22:21:36 INFO - Running post-run listener: _upload_blobber_files 22:21:36 INFO - Blob upload gear active. 22:21:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:21:36 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 22:21:36 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'] 22:21:36 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 22:21:37 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:37 INFO - (blobuploader) - INFO - Done attempting. 22:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:38 INFO - (blobuploader) - INFO - Done attempting. 22:21:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:38 INFO - Return code: 0 22:21:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:21:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ea0feb499c5290f6b6a7cf38c081f12f7b3a7f7aa5c78ffa0e3369e0727ddbf88ad411f0176cff0da6c3f1cb74675957518e68b1355237567e7fee5a38f6126", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42359453e40760a84e441dc826ee2f471db9ec512a6394cc0866c9d7bfebd8dc69e35db687063f664743139157ead55ea1fdfce4c6d912b490d91f2ed7086c57"} 22:21:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:21:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:21:38 INFO - Contents: 22:21:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ea0feb499c5290f6b6a7cf38c081f12f7b3a7f7aa5c78ffa0e3369e0727ddbf88ad411f0176cff0da6c3f1cb74675957518e68b1355237567e7fee5a38f6126", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42359453e40760a84e441dc826ee2f471db9ec512a6394cc0866c9d7bfebd8dc69e35db687063f664743139157ead55ea1fdfce4c6d912b490d91f2ed7086c57"} 22:21:38 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:38 INFO - Copying logs to upload dir... 22:21:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:21:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.285234 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-01-23 22:21:37.958327) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:37.961761) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ea0feb499c5290f6b6a7cf38c081f12f7b3a7f7aa5c78ffa0e3369e0727ddbf88ad411f0176cff0da6c3f1cb74675957518e68b1355237567e7fee5a38f6126", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42359453e40760a84e441dc826ee2f471db9ec512a6394cc0866c9d7bfebd8dc69e35db687063f664743139157ead55ea1fdfce4c6d912b490d91f2ed7086c57"} build_url:https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011434 build_url: 'https://queue.taskcluster.net/v1/task/LINN7KdFRy-M4V9KBVYy7A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ea0feb499c5290f6b6a7cf38c081f12f7b3a7f7aa5c78ffa0e3369e0727ddbf88ad411f0176cff0da6c3f1cb74675957518e68b1355237567e7fee5a38f6126", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42359453e40760a84e441dc826ee2f471db9ec512a6394cc0866c9d7bfebd8dc69e35db687063f664743139157ead55ea1fdfce4c6d912b490d91f2ed7086c57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:37.991316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:37.992035) ========= 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=574dc5aafe09851ec43d388c000001b6-1453609193.681946-1431049774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 22:21:38.081185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 22:21:38.081997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 22:21:38.082664) ========= ========= Total master_lag: 0.29 =========