builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1453039212.6 results: success (0) buildid: 20160117030215 builduid: 678a571586aa47b490810b21bb514838 revision: 5644818538de2413cce52551e32b025e6c7e352e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.597952) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.598326) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.598619) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006483 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.650879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.651170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.746699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.746953) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.798185) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.798446) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.798795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.799065) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-17 06: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.4M=0s 2016-01-17 06:00:13 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099480 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.936076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.936353) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022473 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.985273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:12.985908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5644818538de2413cce52551e32b025e6c7e352e --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 5644818538de2413cce52551e32b025e6c7e352e --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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-17 06:00:13,206 truncating revision to first 12 chars 2016-01-17 06:00:13,206 Setting DEBUG logging. 2016-01-17 06:00:13,206 attempt 1/10 2016-01-17 06:00:13,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5644818538de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-17 06:00:13,585 unpacking tar archive at: mozilla-central-5644818538de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669521 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.670381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.670676) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004612 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.721303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.721592) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.745518) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.745811) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 06:00:13.746184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-17 06:00:13.746472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:00:14 INFO - MultiFileLogger online at 20160117 06:00:14 in /builds/slave/test-pgo 06:00:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:00:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:00:14 INFO - {'append_to_log': False, 06:00:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:00:14 INFO - 'blob_upload_branch': 'Firefox', 06:00:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:00:14 INFO - 'branch': 'Firefox', 06:00:14 INFO - 'buildbot_json_path': 'buildprops.json', 06:00:14 INFO - 'config_files': ('talos/linux_config.py',), 06:00:14 INFO - 'default_actions': ('clobber', 06:00:14 INFO - 'read-buildbot-config', 06:00:14 INFO - 'download-and-extract', 06:00:14 INFO - 'populate-webroot', 06:00:14 INFO - 'create-virtualenv', 06:00:14 INFO - 'install', 06:00:14 INFO - 'run-tests'), 06:00:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:00:14 INFO - 'download_minidump_stackwalk': True, 06:00:14 INFO - 'download_symbols': 'ondemand', 06:00:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:00:14 INFO - 'tooltool.py': '/tools/tooltool.py', 06:00:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:00:14 INFO - '/tools/misc-python/virtualenv.py')}, 06:00:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:00:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:00:14 INFO - 'installer_path': 'installer.exe', 06:00:14 INFO - 'log_level': 'info', 06:00:14 INFO - 'log_name': 'talos', 06:00:14 INFO - 'log_to_console': True, 06:00:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:00:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:00:14 INFO - 'opt_config_files': (), 06:00:14 INFO - 'pip_index': False, 06:00:14 INFO - 'sps_profile': False, 06:00:14 INFO - 'sps_profile_interval': 0, 06:00:14 INFO - 'suite': 'dromaeojs', 06:00:14 INFO - 'system_bits': '32', 06:00:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:00:14 INFO - 'title': 'talos-linux64-ix-062', 06:00:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:00:14 INFO - 'use_talos_json': True, 06:00:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:00:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:00:14 INFO - 'work_dir': 'build'} 06:00:14 INFO - ##### 06:00:14 INFO - ##### Running clobber step. 06:00:14 INFO - ##### 06:00:14 INFO - Running pre-action listener: _resource_record_pre_action 06:00:14 INFO - Running main action method: clobber 06:00:14 INFO - rmtree: /builds/slave/test-pgo/build 06:00:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:00:14 INFO - Running post-action listener: _resource_record_post_action 06:00:14 INFO - ##### 06:00:14 INFO - ##### Running read-buildbot-config step. 06:00:14 INFO - ##### 06:00:14 INFO - Running pre-action listener: _resource_record_pre_action 06:00:14 INFO - Running main action method: read_buildbot_config 06:00:14 INFO - Using buildbot properties: 06:00:14 INFO - { 06:00:14 INFO - "project": "", 06:00:14 INFO - "product": "firefox", 06:00:14 INFO - "script_repo_revision": "production", 06:00:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:00:14 INFO - "repository": "", 06:00:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 06:00:14 INFO - "buildid": "20160117030215", 06:00:14 INFO - "stage_platform": "linux64-pgo", 06:00:14 INFO - "basedir": "/builds/slave/test-pgo", 06:00:14 INFO - "nightly_build": "True", 06:00:14 INFO - "buildnumber": 309, 06:00:14 INFO - "slavename": "talos-linux64-ix-062", 06:00:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:00:14 INFO - "platform": "ubuntu64_hw", 06:00:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 06:00:14 INFO - "branch": "mozilla-central", 06:00:14 INFO - "repo_path": "mozilla-central", 06:00:14 INFO - "revision": "5644818538de2413cce52551e32b025e6c7e352e", 06:00:14 INFO - "pgo_build": "True", 06:00:14 INFO - "builduid": "678a571586aa47b490810b21bb514838", 06:00:14 INFO - "slavebuilddir": "test" 06:00:14 INFO - } 06:00:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:00:14 INFO - Running post-action listener: _resource_record_post_action 06:00:14 INFO - ##### 06:00:14 INFO - ##### Running download-and-extract step. 06:00:14 INFO - ##### 06:00:14 INFO - Running pre-action listener: _resource_record_pre_action 06:00:14 INFO - Running main action method: download_and_extract 06:00:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:00:14 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')]} 06:00:14 INFO - https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/test_packages.json 06:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/test_packages.json 06:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 06:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 06:00:17 INFO - Downloaded 1448 bytes. 06:00:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 06:00:17 INFO - Using the following test package requirements: 06:00:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:00:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:00:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'jsshell-linux-x86_64.zip'], 06:00:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:00:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:00:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:00:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:00:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:00:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:00:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:00:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:17 INFO - https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:20 INFO - Downloaded 22441132 bytes. 06:00:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 06:00:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 06:00:21 INFO - Return code: 0 06:00:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:21 INFO - https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:00:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:00:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:00:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:27 INFO - Downloaded 22441132 bytes. 06:00:27 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'] 06:00:27 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 06:00:28 INFO - Return code: 0 06:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:28 INFO - https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 06:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:30 INFO - Downloaded 11132144 bytes. 06:00:30 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'] 06:00:30 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 06:00:30 INFO - Return code: 0 06:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:30 INFO - https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cblt-Wl7TiC4D-X8nxqq6w/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 06:00:34 INFO - Downloaded 55889365 bytes. 06:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:00:34 INFO - mkdir: /builds/slave/test-pgo/properties 06:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 06:00:34 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 06:00:34 INFO - Contents: 06:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 06:00:34 INFO - Running post-action listener: _resource_record_post_action 06:00:34 INFO - Running post-action listener: set_extra_try_arguments 06:00:34 INFO - ##### 06:00:34 INFO - ##### Running populate-webroot step. 06:00:34 INFO - ##### 06:00:34 INFO - Running pre-action listener: _resource_record_pre_action 06:00:34 INFO - Running main action method: populate_webroot 06:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:00:34 INFO - '--tppagecycles', 06:00:34 INFO - '7'], 06:00:34 INFO - 'tests': ['tsvgm']}}, 06:00:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:00:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:00:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'tests': ['damp', 'tps']}, 06:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['damp', 'tps']}, 06:00:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:00:34 INFO - 'other': {'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'other_l64': {'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'other_nol64': {'tests': ['a11yr', 06:00:34 INFO - 'ts_paint', 06:00:34 INFO - 'tpaint', 06:00:34 INFO - 'sessionrestore', 06:00:34 INFO - 'sessionrestore_no_auto_restore']}, 06:00:34 INFO - 'svgr': {'tests': ['tsvgx', 06:00:34 INFO - 'tsvgr_opacity', 06:00:34 INFO - 'tart', 06:00:34 INFO - 'tscrollx', 06:00:34 INFO - 'cart']}, 06:00:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['tsvgx', 06:00:34 INFO - 'tsvgr_opacity', 06:00:34 INFO - 'tart', 06:00:34 INFO - 'tscrollx', 06:00:34 INFO - 'cart']}, 06:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'tests': ['tp5o']}, 06:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'talos_options': ['--e10s'], 06:00:34 INFO - 'tests': ['tp5o']}, 06:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'talos_options': ['--xperf_path', 06:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:34 INFO - 'tests': ['tp5n']}, 06:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:00:34 INFO - 'talos_options': ['--e10s', 06:00:34 INFO - '--xperf_path', 06:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:00:34 INFO - 'tests': ['tp5n']}}, 06:00:34 INFO - 'talos.zip': {'path': '', 06:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:00:34 INFO - Running post-action listener: _resource_record_post_action 06:00:34 INFO - ##### 06:00:34 INFO - ##### Running create-virtualenv step. 06:00:34 INFO - ##### 06:00:34 INFO - Running pre-action listener: _resource_record_pre_action 06:00:34 INFO - Running main action method: create_virtualenv 06:00:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 06:00:34 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 06:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 06:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:00:34 INFO - Using real prefix '/usr' 06:00:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 06:00:34 INFO - Installing distribute.............................................................................................................................................................................................done. 06:00:36 INFO - Installing pip.................done. 06:00:36 INFO - Return code: 0 06:00:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 06:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:00:36 INFO - Using env: {'DISPLAY': ':0', 06:00:36 INFO - 'HOME': '/home/cltbld', 06:00:36 INFO - 'LANG': 'en_US.UTF-8', 06:00:36 INFO - 'LANGUAGE': 'en_US:en', 06:00:36 INFO - 'LOGNAME': 'cltbld', 06:00:36 INFO - 'MAIL': '/var/mail/cltbld', 06:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:36 INFO - 'MOZ_NO_REMOTE': '1', 06:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:36 INFO - 'NO_EM_RESTART': '1', 06:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:36 INFO - 'SHELL': '/bin/bash', 06:00:36 INFO - 'SHLVL': '1', 06:00:36 INFO - 'TERM': 'linux', 06:00:36 INFO - 'TMOUT': '86400', 06:00:36 INFO - 'USER': 'cltbld', 06:00:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:36 INFO - '_': '/tools/buildbot/bin/python'} 06:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:36 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 06:00:36 INFO - Cleaning up... 06:00:36 INFO - Return code: 0 06:00:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 06:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:00:36 INFO - Using env: {'DISPLAY': ':0', 06:00:36 INFO - 'HOME': '/home/cltbld', 06:00:36 INFO - 'LANG': 'en_US.UTF-8', 06:00:36 INFO - 'LANGUAGE': 'en_US:en', 06:00:36 INFO - 'LOGNAME': 'cltbld', 06:00:36 INFO - 'MAIL': '/var/mail/cltbld', 06:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:36 INFO - 'MOZ_NO_REMOTE': '1', 06:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:36 INFO - 'NO_EM_RESTART': '1', 06:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:36 INFO - 'SHELL': '/bin/bash', 06:00:36 INFO - 'SHLVL': '1', 06:00:36 INFO - 'TERM': 'linux', 06:00:36 INFO - 'TMOUT': '86400', 06:00:36 INFO - 'USER': 'cltbld', 06:00:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:36 INFO - '_': '/tools/buildbot/bin/python'} 06:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:37 INFO - Downloading/unpacking psutil>=0.7.1 06:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:38 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 06:00:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:00:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 06:00:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:38 INFO - Installing collected packages: psutil 06:00:38 INFO - Running setup.py install for psutil 06:00:39 INFO - building 'psutil._psutil_linux' extension 06:00:39 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 06:00:39 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 06:00:39 INFO - building 'psutil._psutil_posix' extension 06:00:39 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 06:00:39 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 06:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:00:39 INFO - Successfully installed psutil 06:00:39 INFO - Cleaning up... 06:00:39 INFO - Return code: 0 06:00:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 06:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:00:39 INFO - Using env: {'DISPLAY': ':0', 06:00:39 INFO - 'HOME': '/home/cltbld', 06:00:39 INFO - 'LANG': 'en_US.UTF-8', 06:00:39 INFO - 'LANGUAGE': 'en_US:en', 06:00:39 INFO - 'LOGNAME': 'cltbld', 06:00:39 INFO - 'MAIL': '/var/mail/cltbld', 06:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:39 INFO - 'MOZ_NO_REMOTE': '1', 06:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:39 INFO - 'NO_EM_RESTART': '1', 06:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:39 INFO - 'SHELL': '/bin/bash', 06:00:39 INFO - 'SHLVL': '1', 06:00:39 INFO - 'TERM': 'linux', 06:00:39 INFO - 'TMOUT': '86400', 06:00:39 INFO - 'USER': 'cltbld', 06:00:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:39 INFO - '_': '/tools/buildbot/bin/python'} 06:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:00:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:00:41 INFO - Installing collected packages: mozsystemmonitor 06:00:41 INFO - Running setup.py install for mozsystemmonitor 06:00:41 INFO - Successfully installed mozsystemmonitor 06:00:41 INFO - Cleaning up... 06:00:41 INFO - Return code: 0 06:00:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 06:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 06:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:00:41 INFO - Using env: {'DISPLAY': ':0', 06:00:41 INFO - 'HOME': '/home/cltbld', 06:00:41 INFO - 'LANG': 'en_US.UTF-8', 06:00:41 INFO - 'LANGUAGE': 'en_US:en', 06:00:41 INFO - 'LOGNAME': 'cltbld', 06:00:41 INFO - 'MAIL': '/var/mail/cltbld', 06:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:41 INFO - 'MOZ_NO_REMOTE': '1', 06:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:41 INFO - 'NO_EM_RESTART': '1', 06:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:41 INFO - 'SHELL': '/bin/bash', 06:00:41 INFO - 'SHLVL': '1', 06:00:41 INFO - 'TERM': 'linux', 06:00:41 INFO - 'TMOUT': '86400', 06:00:41 INFO - 'USER': 'cltbld', 06:00:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:41 INFO - '_': '/tools/buildbot/bin/python'} 06:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:41 INFO - Downloading/unpacking blobuploader==1.2.4 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:41 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 06:00:43 INFO - Downloading blobuploader-1.2.4.tar.gz 06:00:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:00:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 06:00:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:43 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 06:00:44 INFO - Downloading docopt-0.6.1.tar.gz 06:00:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:00:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 06:00:44 INFO - Installing collected packages: blobuploader, requests, docopt 06:00:44 INFO - Running setup.py install for blobuploader 06:00:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:00:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 06:00:44 INFO - Running setup.py install for requests 06:00:45 INFO - Running setup.py install for docopt 06:00:45 INFO - Successfully installed blobuploader requests docopt 06:00:45 INFO - Cleaning up... 06:00:45 INFO - Return code: 0 06:00:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:00:45 INFO - Using env: {'DISPLAY': ':0', 06:00:45 INFO - 'HOME': '/home/cltbld', 06:00:45 INFO - 'LANG': 'en_US.UTF-8', 06:00:45 INFO - 'LANGUAGE': 'en_US:en', 06:00:45 INFO - 'LOGNAME': 'cltbld', 06:00:45 INFO - 'MAIL': '/var/mail/cltbld', 06:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:45 INFO - 'MOZ_NO_REMOTE': '1', 06:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:45 INFO - 'NO_EM_RESTART': '1', 06:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:45 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:45 INFO - 'SHELL': '/bin/bash', 06:00:45 INFO - 'SHLVL': '1', 06:00:45 INFO - 'TERM': 'linux', 06:00:45 INFO - 'TMOUT': '86400', 06:00:45 INFO - 'USER': 'cltbld', 06:00:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:45 INFO - '_': '/tools/buildbot/bin/python'} 06:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:45 INFO - Running setup.py (path:/tmp/pip-pnH0zL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:45 INFO - Running setup.py (path:/tmp/pip-kt612D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:45 INFO - Running setup.py (path:/tmp/pip-xxRFy6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:45 INFO - Running setup.py (path:/tmp/pip-NwtRVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:45 INFO - Running setup.py (path:/tmp/pip-GY5zW0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:46 INFO - Running setup.py (path:/tmp/pip-AfWMSH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:46 INFO - Running setup.py (path:/tmp/pip-WrcSsR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:46 INFO - Running setup.py (path:/tmp/pip-lYYiSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:46 INFO - Running setup.py (path:/tmp/pip-AfWRj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:46 INFO - Running setup.py (path:/tmp/pip-0mXBfq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:46 INFO - Running setup.py (path:/tmp/pip-BAlpOD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:46 INFO - Running setup.py (path:/tmp/pip-udQtO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:46 INFO - Running setup.py (path:/tmp/pip-Q5wJn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:46 INFO - Running setup.py (path:/tmp/pip-Fa7l80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:46 INFO - Running setup.py (path:/tmp/pip-tmlbiS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:46 INFO - Running setup.py (path:/tmp/pip-mpHhgm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:46 INFO - Running setup.py (path:/tmp/pip-M9KgD0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:00:46 INFO - Running setup.py install for manifestparser 06:00:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for mozcrash 06:00:47 INFO - Running setup.py install for mozdebug 06:00:47 INFO - Running setup.py install for mozdevice 06:00:47 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for mozfile 06:00:47 INFO - Running setup.py install for mozhttpd 06:00:47 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for mozinfo 06:00:47 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for mozInstall 06:00:47 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for mozleak 06:00:47 INFO - Running setup.py install for mozlog 06:00:47 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 06:00:47 INFO - Running setup.py install for moznetwork 06:00:48 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Running setup.py install for mozprocess 06:00:48 INFO - Running setup.py install for mozprofile 06:00:48 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Running setup.py install for mozrunner 06:00:48 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Running setup.py install for mozscreenshot 06:00:48 INFO - Running setup.py install for moztest 06:00:48 INFO - Running setup.py install for mozversion 06:00:48 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 06:00:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:00:48 INFO - Cleaning up... 06:00:48 INFO - Return code: 0 06:00:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 06:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:00:48 INFO - Using env: {'DISPLAY': ':0', 06:00:48 INFO - 'HOME': '/home/cltbld', 06:00:48 INFO - 'LANG': 'en_US.UTF-8', 06:00:48 INFO - 'LANGUAGE': 'en_US:en', 06:00:48 INFO - 'LOGNAME': 'cltbld', 06:00:48 INFO - 'MAIL': '/var/mail/cltbld', 06:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:48 INFO - 'MOZ_NO_REMOTE': '1', 06:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:48 INFO - 'NO_EM_RESTART': '1', 06:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:48 INFO - 'SHELL': '/bin/bash', 06:00:48 INFO - 'SHLVL': '1', 06:00:48 INFO - 'TERM': 'linux', 06:00:48 INFO - 'TMOUT': '86400', 06:00:48 INFO - 'USER': 'cltbld', 06:00:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:48 INFO - '_': '/tools/buildbot/bin/python'} 06:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:48 INFO - Running setup.py (path:/tmp/pip-gzIf1x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 06:00:48 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)) 06:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:48 INFO - Running setup.py (path:/tmp/pip-1onLbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:49 INFO - Running setup.py (path:/tmp/pip-np6uZq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:49 INFO - Running setup.py (path:/tmp/pip-RuSvrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:49 INFO - Running setup.py (path:/tmp/pip-UIz_bn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:49 INFO - Running setup.py (path:/tmp/pip-b9I26B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:49 INFO - Running setup.py (path:/tmp/pip-RCRTMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:49 INFO - Running setup.py (path:/tmp/pip-H7gYZU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:49 INFO - Running setup.py (path:/tmp/pip-39HKXo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:49 INFO - Running setup.py (path:/tmp/pip-IW0zEA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:49 INFO - Running setup.py (path:/tmp/pip-1_LBY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:49 INFO - Running setup.py (path:/tmp/pip-wlJ9tu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:49 INFO - Running setup.py (path:/tmp/pip-EQgLc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:49 INFO - Running setup.py (path:/tmp/pip-xmvUHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 06:00:49 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)) 06:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:49 INFO - Running setup.py (path:/tmp/pip-MlSUP6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 06:00:50 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)) 06:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:50 INFO - Running setup.py (path:/tmp/pip-0fdxV0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 06:00:50 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)) 06:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:50 INFO - Running setup.py (path:/tmp/pip-_O_RDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 06:00:50 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)) 06:00:50 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)) 06:00:50 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)) 06:00:50 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)) 06:00:50 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)) 06:00:50 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)) 06:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 06: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 06: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 06: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 06: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 06: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 06: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 06:00:51 INFO - Downloading blessings-1.5.1.tar.gz 06:00:51 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:00:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:51 INFO - Installing collected packages: blessings 06:00:51 INFO - Running setup.py install for blessings 06:00:52 INFO - Successfully installed blessings 06:00:52 INFO - Cleaning up... 06:00:52 INFO - Return code: 0 06:00:52 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 06:00:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:00:52 INFO - Reading from file tmpfile_stdout 06:00:52 INFO - Current package versions: 06:00:52 INFO - argparse == 1.2.1 06:00:52 INFO - blessings == 1.5.1 06:00:52 INFO - blobuploader == 1.2.4 06:00:52 INFO - docopt == 0.6.1 06:00:52 INFO - manifestparser == 1.1 06:00:52 INFO - mozInstall == 1.12 06:00:52 INFO - mozcrash == 0.16 06:00:52 INFO - mozdebug == 0.1 06:00:52 INFO - mozdevice == 0.48 06:00:52 INFO - mozfile == 1.2 06:00:52 INFO - mozhttpd == 0.7 06:00:52 INFO - mozinfo == 0.9 06:00:52 INFO - mozleak == 0.1 06:00:52 INFO - mozlog == 3.1 06:00:52 INFO - moznetwork == 0.27 06:00:52 INFO - mozprocess == 0.22 06:00:52 INFO - mozprofile == 0.28 06:00:52 INFO - mozrunner == 6.11 06:00:52 INFO - mozscreenshot == 0.1 06:00:52 INFO - mozsystemmonitor == 0.0 06:00:52 INFO - moztest == 0.7 06:00:52 INFO - mozversion == 1.4 06:00:52 INFO - psutil == 3.1.1 06:00:52 INFO - requests == 1.2.3 06:00:52 INFO - wsgiref == 0.1.2 06:00:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 06:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:00:52 INFO - Using env: {'DISPLAY': ':0', 06:00:52 INFO - 'HOME': '/home/cltbld', 06:00:52 INFO - 'LANG': 'en_US.UTF-8', 06:00:52 INFO - 'LANGUAGE': 'en_US:en', 06:00:52 INFO - 'LOGNAME': 'cltbld', 06:00:52 INFO - 'MAIL': '/var/mail/cltbld', 06:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:52 INFO - 'MOZ_NO_REMOTE': '1', 06:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:52 INFO - 'NO_EM_RESTART': '1', 06:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:52 INFO - 'SHELL': '/bin/bash', 06:00:52 INFO - 'SHLVL': '1', 06:00:52 INFO - 'TERM': 'linux', 06:00:52 INFO - 'TMOUT': '86400', 06:00:52 INFO - 'USER': 'cltbld', 06:00:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:52 INFO - '_': '/tools/buildbot/bin/python'} 06:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 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)) 06:00:52 INFO - Cleaning up... 06:00:52 INFO - Return code: 0 06:00:52 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 06: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')]} 06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06: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')]} 06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 06:00:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:00:52 INFO - Using env: {'DISPLAY': ':0', 06:00:52 INFO - 'HOME': '/home/cltbld', 06:00:52 INFO - 'LANG': 'en_US.UTF-8', 06:00:52 INFO - 'LANGUAGE': 'en_US:en', 06:00:52 INFO - 'LOGNAME': 'cltbld', 06:00:52 INFO - 'MAIL': '/var/mail/cltbld', 06:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:52 INFO - 'MOZ_NO_REMOTE': '1', 06:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:52 INFO - 'NO_EM_RESTART': '1', 06:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:52 INFO - 'SHELL': '/bin/bash', 06:00:52 INFO - 'SHLVL': '1', 06:00:52 INFO - 'TERM': 'linux', 06:00:52 INFO - 'TMOUT': '86400', 06:00:52 INFO - 'USER': 'cltbld', 06:00:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:52 INFO - '_': '/tools/buildbot/bin/python'} 06:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:52 INFO - Downloading/unpacking jsonschema 06:00:52 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 06:00:52 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 06:00:52 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 06:00:52 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 06:00:52 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 06:00:52 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 06:00:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:00:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:00:54 INFO - Downloading/unpacking functools32 (from jsonschema) 06:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:00:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 06:00:54 INFO - warning: no files found matching '*.txt' 06:00:54 INFO - no previously-included directories found matching 'build' 06:00:54 INFO - no previously-included directories found matching 'dist' 06:00:54 INFO - no previously-included directories found matching '.git*' 06:00:54 INFO - Installing collected packages: jsonschema, functools32 06:00:54 INFO - Running setup.py install for functools32 06:00:54 INFO - warning: no files found matching '*.txt' 06:00:54 INFO - no previously-included directories found matching 'build' 06:00:54 INFO - no previously-included directories found matching 'dist' 06:00:54 INFO - no previously-included directories found matching '.git*' 06:00:54 INFO - Successfully installed jsonschema functools32 06:00:54 INFO - Cleaning up... 06:00:54 INFO - Return code: 0 06:00:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 06:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f146b0c5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x237e480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', '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 06:00:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 06:00:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:00:54 INFO - Using env: {'DISPLAY': ':0', 06:00:54 INFO - 'HOME': '/home/cltbld', 06:00:54 INFO - 'LANG': 'en_US.UTF-8', 06:00:54 INFO - 'LANGUAGE': 'en_US:en', 06:00:54 INFO - 'LOGNAME': 'cltbld', 06:00:54 INFO - 'MAIL': '/var/mail/cltbld', 06:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:54 INFO - 'MOZ_NO_REMOTE': '1', 06:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:00:54 INFO - 'NO_EM_RESTART': '1', 06:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 06:00:54 INFO - 'SHELL': '/bin/bash', 06:00:54 INFO - 'SHLVL': '1', 06:00:54 INFO - 'TERM': 'linux', 06:00:54 INFO - 'TMOUT': '86400', 06:00:54 INFO - 'USER': 'cltbld', 06:00:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:54 INFO - '_': '/tools/buildbot/bin/python'} 06:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:55 INFO - Downloading/unpacking flake8 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:00:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:00:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06: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 06: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 06: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 06: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 06: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 06: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 06:00:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:00:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:00:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 06:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:57 INFO - no previously-included directories found matching 'docs/_build' 06:00:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:00:57 INFO - Running setup.py install for pep8 06:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:00:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:00:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:00:57 INFO - no previously-included directories found matching 'docs/_build' 06:00:57 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 06:00:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:00:57 INFO - Cleaning up... 06:00:57 INFO - Return code: 0 06:00:57 INFO - Running post-action listener: _resource_record_post_action 06:00:57 INFO - Running post-action listener: _start_resource_monitoring 06:00:57 INFO - Starting resource monitoring. 06:00:57 INFO - ##### 06:00:57 INFO - ##### Running install step. 06:00:57 INFO - ##### 06:00:57 INFO - Running pre-action listener: _resource_record_pre_action 06:00:57 INFO - Running main action method: install 06:00:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 06:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 06:00:58 INFO - Reading from file tmpfile_stdout 06:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 06:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 06:00:58 INFO - Reading from file tmpfile_stdout 06:00:58 INFO - Output received: 06:00:58 INFO - Usage: mozinstall [options] installer 06:00:58 INFO - Options: 06:00:58 INFO - -h, --help show this help message and exit 06:00:58 INFO - -d DEST, --destination=DEST 06:00:58 INFO - Directory to install application into. [default: 06:00:58 INFO - "/builds/slave/test-pgo"] 06:00:58 INFO - --app=APP Application being installed. [default: firefox] 06:00:58 INFO - mkdir: /builds/slave/test-pgo/build/application 06:00:58 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'] 06:00:58 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 06:01:14 INFO - Reading from file tmpfile_stdout 06:01:14 INFO - Output received: 06:01:14 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 06:01:14 INFO - Running post-action listener: _resource_record_post_action 06:01:14 INFO - ##### 06:01:14 INFO - ##### Running run-tests step. 06:01:14 INFO - ##### 06:01:14 INFO - Running pre-action listener: _resource_record_pre_action 06:01:14 INFO - Running main action method: run_tests 06:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 06:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 06:01:14 INFO - Python 2.7.3 06:01:14 INFO - Return code: 0 06:01:14 INFO - grabbing minidump binary from tooltool 06:01:14 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')]} 06:01:14 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 0x240d660>, '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 0x240e560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x240ea10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 06:01:14 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 06:01:14 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 06:01:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:01:14 INFO - Return code: 0 06:01:14 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 06:01:14 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 06:01:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 06:01:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 06:01:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 06:01:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 06:01:15 INFO - Return code: 0 06:01:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 06:01:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 06:01:15 INFO - Using env: {'DISPLAY': ':0', 06:01:15 INFO - 'HOME': '/home/cltbld', 06:01:15 INFO - 'LANG': 'en_US.UTF-8', 06:01:15 INFO - 'LANGUAGE': 'en_US:en', 06:01:15 INFO - 'LOGNAME': 'cltbld', 06:01:15 INFO - 'MAIL': '/var/mail/cltbld', 06:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 06:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:01:15 INFO - 'MOZ_NO_REMOTE': '1', 06:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 06:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:01:15 INFO - 'NO_EM_RESTART': '1', 06:01:15 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 06:01:15 INFO - 'PWD': '/builds/slave/test-pgo', 06:01:15 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 06:01:15 INFO - 'SHELL': '/bin/bash', 06:01:15 INFO - 'SHLVL': '1', 06:01:15 INFO - 'TERM': 'linux', 06:01:15 INFO - 'TMOUT': '86400', 06:01:15 INFO - 'USER': 'cltbld', 06:01:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869', 06:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:01:15 INFO - '_': '/tools/buildbot/bin/python'} 06:01:15 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:01:15 INFO - mozversion application_buildid: 20160117030215 06:01:15 INFO - mozversion application_changeset: 5644818538de2413cce52551e32b025e6c7e352e 06:01:15 INFO - mozversion application_display_name: Nightly 06:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:01:15 INFO - mozversion application_name: Firefox 06:01:15 INFO - mozversion application_remotingname: firefox 06:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:01:15 INFO - mozversion application_vendor: Mozilla 06:01:15 INFO - mozversion application_version: 46.0a1 06:01:15 INFO - mozversion platform_buildid: 20160117030215 06:01:15 INFO - mozversion platform_changeset: 5644818538de2413cce52551e32b025e6c7e352e 06:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:01:15 INFO - mozversion platform_version: 46.0a1 06:01:15 INFO - using testdate: 1453039275 06:01:15 INFO - actual date: 1453039275 06:01:15 INFO - starting webserver on 'localhost:43621' 06:01:15 INFO - SUITE-START | Running 3 tests 06:01:15 INFO - TEST-START | dromaeo_css 06:01:15 INFO - operating with platform_type : linux_ 06:01:15 INFO - Initialising browser for dromaeo_css test... 06:01:15 INFO - TEST-INFO | started process 5094 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdmgq0/profile http://localhost:43621/getInfo.html) 06:01:19 INFO - PROCESS | 5094 | __metrics Screen width/height:1600/1200 06:01:19 INFO - PROCESS | 5094 | colorDepth:24 06:01:19 INFO - PROCESS | 5094 | Browser inner width/height: 1024/697 06:01:19 INFO - PROCESS | 5094 | __metrics 06:01:20 INFO - PROCESS | 5094 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:01:20 INFO - PROCESS | 5094 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:01:21 INFO - TEST-INFO | 5094: exit 0 06:01:21 INFO - Browser initialized. 06:01:21 INFO - Running cycle 1/1 for dromaeo_css test... 06:01:21 INFO - TEST-INFO | started process 5191 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRdmgq0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:01:33 INFO - PROCESS | 5191 | RSS: Main: 149864448 06:01:33 INFO - PROCESS | 5191 | 06:02:23 INFO - PROCESS | 5191 | 1453039343986 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] 06:04:33 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43621/tests/dromaeo/cssquery-ext.html) 06:04:34 INFO - PROCESS | 5191 | RSS: Main: 270671872 06:04:34 INFO - PROCESS | 5191 | 06:07:36 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-ext.html (next: http://localhost:43621/tests/dromaeo/cssquery-jquery.html) 06:07:37 INFO - PROCESS | 5191 | RSS: Main: 237916160 06:07:37 INFO - PROCESS | 5191 | 06:10:39 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43621/tests/dromaeo/cssquery-mootools.html) 06:10:39 INFO - PROCESS | 5191 | RSS: Main: 245780480 06:10:39 INFO - PROCESS | 5191 | 06:13:41 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43621/tests/dromaeo/cssquery-prototype.html) 06:13:42 INFO - PROCESS | 5191 | RSS: Main: 213479424 06:13:42 INFO - PROCESS | 5191 | 06:16:44 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43621/tests/dromaeo/cssquery-yui.html) 06:16:45 INFO - PROCESS | 5191 | RSS: Main: 216240128 06:16:45 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | Cycle 1(1): loaded http://localhost:43621/tests/dromaeo/cssquery-yui.html (next: http://localhost:43621/tests/dromaeo/cssquery-dojo.html) 06:19:48 INFO - PROCESS | 5191 | RSS: Main: 239251456 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | __start_tp_report 06:19:48 INFO - PROCESS | 5191 | _x_x_mozilla_page_load 06:19:48 INFO - PROCESS | 5191 | _x_x_mozilla_page_load_details 06:19:48 INFO - PROCESS | 5191 | |i|pagename|runs| 06:19:48 INFO - PROCESS | 5191 | |0;dojo.html;3145.795523290986;3175.571297874786;3219.871205151794;3221.822799746014;3231.5798946136997;5078.263651770491;5172.793088276464;5181.5854731621475;5188.922166167506;5204.32343795306;5109.821156259532;5186.7925282988635;5194.298769666094;5213.348331458567;5262.315898933143;4730.479647238801;4734.763261836912;4753.90492190156;4768.117898188846;4771.379720636312;4803.327534145223;4841.394825646794;4866.197077482211;4888.535589119028;4909.705417674933;4561.429821272324;4635.490096089427;4659.161350956826;4720.787564559569;4766.451858036318;4641.883952901205;4740.360051393052;4753.906601481644;4761.8095276188915;4766.356541866839;4652.092841895832;4662;4674.859754207379;4679.27471241958;4705.505921878222;4943.307936888838;4960.627952903546;5004.923941352627;5034.395872495324;5066.06277838601;5449.700266485342;5467.398586155519;5471.398146203915;5471.8084867029465;5472.124460086367;5431.728413579344;5437.265969094161;5456.91814622781;5488.204210389471;5500.532454741352;5057.570106540912;5078.7460626968505;5082.542571168576;5138.948610513922;5143.5627971622835;5672.574556908248;5694;5696.8860622787315;5711;5720.11338242573;5367.570594352443;5449.128139497661;5467.644603100865;5477.534409575151;5492.47821456961;5369.4362091980565;5523.337199536081;5574.581906356958;5578.470045345685;5592.552595792326;5531.308586426697;5571.554275657938;5578.330600327987;5578.44215578447;5580.469855363734;5521;5545.528630066409;5564.888702225933;5566.081596536607;5574.86062848432;4223.957760422418;4295.892602684896;4304.311310190355;4340.066885619607;4377.037051848588;3859.6526312632;3860.343741563941;3880.4567360569545;3898.493195884517;3922.3920292354733;5157.432682405008;5162.1224391853475;5170.870728231825;5174.715390653475;5214.983078299771;5334.599905007062;5416.972915135478;5469.726513674301;5516.172574113915;5534.972325138348;5067.771950262247;5070.138076527;5106.744662766847;5124.30821839047;5140.151874940668;4739.691920025188;4739.715617062987;4743.146233677902;4746.477887432379;4782.832600858953;5609.551235901118;5706.315242170883;5724.370319264877;5800.941990580124;5813.040848260159;5469.15228139639;5506.944930550643;5507.118860982224;5509.779608815603;5517.062099443024;5728.140778883201;5736.053551164011;5740.454656807597;5741.885162296814;5749;5313.920291195558;5340.225667278145;5363.463653634762;5418.566514678895;5460.535854452257;5575.135853942646;5590.413006634245;5596.972015139898;5598.972005139948;5600.131979543177;5285.550728188147;5446.972765136149;5467.261919640957;5480.342358916955;5515.586331025109;5344.679319240858;5390.110631745875;5390.4879036491475;5446.836594902159;5494.2582751328055;5253.23828044939;5295.417504074471;5297.17893726473;5299;5302.655327403706;5423.674579525241;5427.48438898304;5455.809046683347;5458.972705136449;5480.3971563127225;5241.31862857826;5302.681839089667;5313.1764576490705;5320.201969704575;5359.035373632628 06:19:48 INFO - PROCESS | 5191 | |1;ext.html;525.398418810462;531.0679757026415;539.8380485854245;557.2504980800823;560.9074502707053;29420.558691619615;29809.40381192375;29825.254368640795;29860.402791944176;29866.25334366642;37221.44167837478;37868.43197352035;37899.24201515968;37932.810335948285;37984.341096123215;8419.789505262386;8595.312375009984;8595.355348348867;8603.827923441528;8605.39762216645;8318.334533237357;8485.193906578865;8486.448380855256;8486.490810551355;8486.957565212166;8453.45052571584;8534.829303413928;8543.57282135894;8550.486970781772;8550.572471376438;8421.789455263637;8509.361797865124;8511.319094472488;8512.063672995966;8516.70191543293;8377.6230069647;8413.326933845277;8606.956965215197;8627.525486098262;8627.6980305689;35983.64016359855;36304.45543316852;36366.454503182475;38791.224175516334;39092.60907390918;3270.049522146034;3282.3599398117376;3426.9657303427143;3578.874739384135;3600.531930848999;26522.469550609072;27193.04824331139;27227.86386068077;27306;27349.589756153673;3787.299349620329;3841.3277676406797;3908.4528166056775;3954.3475326571083;3971.2653159165648;273520;278697;278865;279267;279539;59086.704566476896;60323;60348;60425.69787151124;60548.39451605516;64048.67975660092;64333;64715.67642161853;64734.35265647378;64779.352206477335;14338.139711617336;14463.710725785426;14467.348969296196;14529.273536323142;14565.126092434488;10891.83662245067;10943.781124377469;10968.616098436676;10976.176786741027;10981.670549883516;19414.902925485283;20234.79765202329;20241.291554795513;20285;20298.492537686678;7815.6482958267015;7904.723334683258;8016.599170041474;8039.557824319601;8078.636461359253;786.7089177004545;910.9635614575475;965.8406362950175;975.7560609847538;1047.607147319755;25369.238922831977;25760.355991100372;25847;25972;26008.08971685982;974.152487336008;977.296346630425;1045.5399624165343;1051.5215576912487;1121.327203677803;13964.72070558583;14071.788923166161;14215.147091174562;14260.144391336346;14561.78157327641;307760;315505;315807;316031;316964;46865.76567117142;48000.51999479961;49699.254511182364;50777.746111269946;51403.485965140615;1258.1947553565726;1272.923624582528;1275.8851703346559;1285.774989376874;1320.3002408723391;25887.870560647076;26490.86754566215;27899.302517437227;27977.300567485974;28604.85697571499;46122.53877461182;46641;46724.29913551368;46731.53268467408;46731.76634116808;244556;247212;247449;247482;247593;32521.512177317833;32908.341833162725;33144.83427582846;33329.83335083309;33367.33265334728;42171;43173.78413107914;43626.78186609047;43758.12483750371;44164.77917610391;36400;36452.81773591115;36676.63323366839;37427.43858842174;38116;35611.82194089013;36129.27741445209;37007.444888327234;37154.628453715115;37222.813885930394;30073;30681.386372272875;30686.386272274874;30727.846360768053;31287;32289.35421291608;33004.17489562684;33571.49642755312;33626.159346016546;33636;25501;26272.60591091097;26289.868550657124;26333;26699.866500667373 06:19:48 INFO - PROCESS | 5191 | |2;jquery.html;356.0937414280656;360.3333832410042;360.922401683638;365.1473808656786;367.8069013767773;13760.967927405434;13836.031477796532;15805.367785288588;16905;18237.270509179634;10152.441615711134;10512.842307365396;16437.09595972221;16954.321827126932;17027.148642567852;4848.248521479159;5009.799608015675;5009.974950125263;5011;5012.72430016349;3678.4850120983083;3823.120682243086;4931.605471562284;4977.452480227172;6543.770968016121;6516.152900122977;6813.9318606813795;6855.965720171393;6856.2800905904905;6858.074159988412;6519.93480065198;6539.117219175398;6568.9014664779825;6578.539502234846;6578.60528368297;6205.968970155121;6532.542722009462;6551;6555.213374395055;6555.410013098844;20258.898705506377;21912.671309930363;22719.545609087727;22959.885200574055;22961.196358127552;2050.5796311756053;2081.261152290945;2116.216999710102;2153.493928926701;2161.059938926572;11878.821817672742;13306.80039799394;13615.727685446236;13690.452381904712;13917.512887048904;1721.7847769028872;1876.7560217171817;1890.914908829106;1947.4547126804375;1960.9411717648493;64338.034929476096;65191.674041629485;65905.67047164781;66226.33773662298;66542.66728666374;9669.758256043515;9753.804923901624;9839.508024598741;9959.203263738884;10044.895061543224;12927.870721292855;13134.014948878872;13134.277614731282;13139.54011609589;13145.53990610324;6782.253952065269;6798.354156355138;7012;7057.611831349325;7233.31283528064;6553.901691474632;6562.343765623495;6582.703778329987;6729.158855143107;6813.659317034128;4040.313146765057;4361.193179261847;4363.825446982085;4408.140412619508;4495.527969563214;1722.0442654326719;1762.1365530890027;1792.7948623193545;1794.4616615015443;1795.524186090687;441.56505841745854;452.47738861614886;823.950562966224;1004.5278719002057;1028.1517747858047;10028.849567256497;10556.630517931835;10720.517576709066;10765.677029689123;10845.945770271099;418.20749679358056;442.1113561740924;459.6598517097324;476.97853596587544;488.0799692579513;5779.104238842986;5940.4653581177035;5941.910871336933;5998.880022399528;6032.788852390146;345387;366808;370256;371790;381055;54855.177172342446;66196.05647322352;70802.29197707957;74888.62555687295;75296;1125.3079356196045;1125.4035361258382;1150.344303746873;1160.2748282323548;1168.404113901899;13678.452861885811;14292.069236113524;14582.270886455846;15174.393024278905;15444.691106178037;32546.349073018882;32643.34713305673;33601.66398335985;33777.83111084429;33848.49227261642;39217.411738824514;39909.401358979056;41043.384349235384;41657.37513937233;42155.57844421516;7339.302766237199;7435.859114233092;7474.869662146262;7509.286617771303;7601.809954751176;8530.573471326285;11166.330020198815;11405.828912566483;11468.197226194086;11587.362695051854;9361.110694484014;9480;9538.284628653018;9962.501874906371;10294.3823370598;9811.313208075366;9918;10285.691429257135;10299.897001029894;10330.018648228406;8068.838623227385;10037.49812509357;10254.179665626882;10257.28199026061;10511.57953681844;7394.704211831467;7589.886151707839;7598.506097103671;7627.961860190663;7651.234876512304;9661.695671084313;10083.848742268725;10094.949525252327;10201.132903703268;10253 06:19:48 INFO - PROCESS | 5191 | |3;mootools.html;1310.2007775257086;1487.7917091607173;1494.940202391904;1664.9084300363475;1808.8552915766732;7141.678624461899;7598.506097103691;7766.456348055638;7775.30022297993;7777.766666999992;7776.066871975357;7785.26040026198;7939.880901786478;7978.680852765897;7985.680572777096;2021.2622392826586;2072.2332736887374;2301.056566807609;2365.207655435431;2397.976020239793;2348.1898744933055;2351.823613229015;2355.7997570206553;2358.705161854768;2361.3506285771464;2298.5517824024323;2370.5140446208484;2371.039728909794;2371.312319427364;2374.6675465434855;2257.81937445004;2288.599495088353;2333.300009997011;2333.778291062355;2340.040583360831;2306.850054746436;2307.0541078157876;2334.9182778602667;2339.7075365579303;2376.144587948337;7900.32847207988;7933.9603301983125;7942.404319675989;7991.640376183086;8017.559034253114;4819.325294458778;4925;4957.033378491195;4967.205247160437;4977.203647416396;3180.761442891769;3291.308825146722;3297.093299342676;3300.356430496054;3355.2953879685297;1015.4262841494532;1015.6546774096843;1050.9527071281811;1057.5875408590655;1072.8283474644097;11346.773064538746;11362.886371136265;11367.545298188063;11388.316700997966;11388.772224555545;4532.116237333688;4601.792919318638;4611.33135695329;4613.63090952723;4638.605718513964;9423.01058388873;9456.479893605918;9458.290628202913;9462.195713364441;9579.425234485952;4955.4796746341835;4983.127952608352;4983.750812459362;4986.750662466935;4992.350994370709;4452.154090722753;4481.708688935209;4482.058767658828;4489.820407183742;4499.257622492252;3403.7447191460737;3457.7233821294235;3464.995151406064;3661.2860492203763;3735.290294843971;1197.233770386953;1199.6401079676061;1210.8728583498782;1212.3877441891964;1220.1398014399826;1079.3469950679882;1100.6753007862699;1102.3385968418884;1240.64021433785;1370.712150448397;7322.597257150801;7415.221401752846;7472.85054298911;7488.9625551871895;7521.811954701177;1105.5467258424007;1111.5387114347454;1112.7218195451137;1112.9554817807198;1142.7771584540935;5838.328592211865;5942.494887934487;5956.076808094752;6024.367441418675;6032.276126864716;9178.082191780903;9458.716238512856;9560.330776845693;9616.134547890724;9737.513124343754;9364.204042656314;9484.525773711286;9485.66800161991;9576.76058098553;9600.135987760996;7151.749688760869;7247.782566523013;7273.599952002585;7374.188839227788;7386.778396648109;7357.0803649543805;7428.33145016951;7434.182239953492;7448.292412220831;7451.2921272479025;8058.476199047278;8286;8378.120297368689;8476.364272679697;8572.871406928776;8492.532910689972;8567.914320856711;8730.650773969224;8754.29965602763;8760.868586971073;6734.3602357775935;6915.654217289216;7008.0889484368745;7057.964710176417;7059.611721355374;6952.235254121942;7096.964515177391;7360.07999000125;7594.5063570867715;7611.391088712779;6932.23745388017;7159;7204.351608355273;7250.89123663156;7263.293126115253;7085.574865508086;7138.535995160298;7145.678444470115;7232.63836808147;7359.8160045999275;7247.13034435871;7293.52592081513;7298;7332.156801967842;7350.963245183953;6733.225679046776;6775.119234499483;6798.252192258748;6799.3200679931615;6810.659467026728;6682.699278532575;6717.529772915849;6754.797356079325;6758.560693554903;6791.796246112624 06:19:48 INFO - PROCESS | 5191 | |4;prototype.html;345.53007909243433;356.2163240870085;357.324656399405;359.4482469409457;361.1765175400089;5581.441855814416;5744.79893203738;5768.653880767157;5807.73865176067;5821.563382746301;5601.80393686221;5660.377358490563;5715.914261286084;5727.198192253088;5754.827355179351;4413.470383553978;4448.28827387618;4462.776861156945;4481.5070342262325;4499.977500112511;4261.169072030955;4379.934300985487;4483.4171557697455;4500.504944456107;4505.234110201257;4172.687048471362;4302.48370195577;4337.327714204288;4343.153085148398;4445.310976798602;4433.733975961452;4435.756033418177;4468.419105516295;4478.395416618748;4491.550844915515;3954.7033972451895;3984.083660758042;3984.820683069269;3995.2409042281874;3998.7800670963084;5522.585806064521;5528.530074943635;5532;5536.529395001429;5552.944470555283;5069.543741063285;5140.511651393112;5141.126008578551;5179.223116532513;5192.558632516203;6033.909491357633;6045.969770151165;6048.60684055535;6054.091886217103;6056.5457590680435;4318.244307246219;4326.610605045561;4332.1119170569955;4335.436393268887;4340;6037.4566289033755;6175.845603859894;6216.316205217422;6356.14192084072;6362.5546211765195;4471.038726673716;4492.483364413069;4494.752788596658;4511.3458548510935;4520.276755719069;4562.608404436679;4565.406497155349;4567.337736028324;4571.062932098912;4571.131485017836;5038.496150384932;5158.742062896915;5173.172292433268;5176.094183517869;5176.327077479904;6098.451139397475;6101.206843110367;6114.144019837227;6115.969420152871;6125.693715314216;1596.233807772276;1607.6865011322914;1609.0506601105403;1611.5971007248188;1612.7500237463212;1076.05844885725;1096.555894862582;1103.8840921703106;1108.3737688206138;1117.312852595664;5762.654240745569;5772.5670574707065;5776.277965254343;5785.10330898703;5786.334571524244;6239.750409983641;6247.344028876993;6253.96873015632;6255.186825712719;6265.8746825063245;5761.452661997104;5765.164051212634;5773;5776.711164441761;5782.971085144547;3260.543523906655;3368.208471009311;3371.3088816792497;3376.206591451007;3376.679215474526;6487.513436492282;6493.928501797245;6503.154589903283;6513.990331498625;6561.048647946117;6373.235211774617;6385.2656944451055;6397.424231819158;6398.584092034003;6441.162648855712;6323.652199129;6481.805545833632;6538.574992625559;6559.8032059038305;6568.211814582281;6256.562040657111;6260.467860231749;6261.311255761953;6262.123302737711;6263.686815659108;5995.730192141451;6168.321484636776;6181.258249009968;6187.102870083902;6190.380961903774;6383.106365108982;6469.902951455638;6516.543841931209;6579.078928949855;6609.669516524251;4529.909401812011;4537.886552836206;4538.341940418687;4541.069080838354;4549.613282870993;6039.607425517327;6133.294671112879;6188.257409110935;6327.17746692927;6336.20797400325;6129.969350153399;6136.539759517965;6164.4143806338325;6179.165812615419;6194.690265486617;6094.08588711679;6103.359147289649;6109.2974307955155;6163.476104530986;6171.506279497539;5904.468597826044;5990.760369585168;5997.940020599738;6053.939460605337;6114.960456722457;6208.068789681584;6237.251529816451;6251.9062214067735;6329.968350158219;6332.145160403286;6054.727537260922;6066.605670631395;6094.969525152524;6097.7865774697675;6099.3290738017895 06:19:48 INFO - PROCESS | 5191 | |5;yui.html;684.1960696181986;714.678394722375;752.2853289375095;752.4206361101951;834.1491678487943;12966.351682415876;13040.478380864777;13110.34448277586;13153.802692959602;13160;12382.133250672456;12438.129330946836;12452.688682782935;12871.420786064626;13229.272390018545;763.0728664672408;780.9414293927949;782.1904329019466;783.1033466680648;783.385042741448;773.6557232031748;774.5507605588773;775.4261846233803;775.9185285545021;776.0532150776072;810.3112354498688;811.4157806379427;812.5693382507251;813.6460639621754;813.8697808350665;811.9188081191893;812.0945146162046;812.2446125103651;813.1015228172872;813.7355359508153;594.5986459140106;595.2410676387597;595.3451203675921;596.991085066241;597.3608239184075;12053.2165409249;12141;12171.93914030433;12176.57381991635;12220.877791222063;10932.56269749209;11008.119350451945;11051.557937682563;11084.501197446134;11418.200725949187;9375.671851485233;9451.102145296185;9489.240860731194;9533.666321678777;9762.414255144644;3528.1356067763304;3591.281743651254;3596.4245720684567;3602.513660655804;3671.9265614687824;44979;44991.32513012308;45048.3242751359;45179;45282.773586132185;8571.914280857112;8604.741857744277;8618.870716939251;8779.429337093068;8836.602352894006;16070.196490175444;16143.434979775651;16173.676526469404;16189.271482783302;16194.271257793427;7536.171021187665;7540.773776786705;7782.416318776114;7857.842843143105;7894.171112033268;4234.915301693949;4252.914941701149;4347.804348804311;4364.4980827204645;4411.448568928884;3093.6751641077362;3148.7323577495713;3155.9684403156134;3163.6994485523837;3176.5076413155534;549.9780008799684;562.1511517608359;568.9658620482784;570.965742055478;574.0757380617202;512.5259135299833;522.5088416888113;535.165142377884;584.9590528663038;657.9342065793383;8092.190780921861;8294.626741796634;8412.15878412166;8450.619722112397;8804.955975220082;656.2420404432887;657.4904449052023;659.7229163751236;679.7349033876792;692.0311563810706;3801.258754542838;3858.8456461741775;4079.7756123413496;4156.542780294165;4188.832446702158;53553;53982;54149;54481;54594.45405545894;44563.777181114536;45124.77437612791;45299.77350113228;47503.5249647506;48534;41974.74075777731;42072.57927420748;42275.94310142333;43988;44055.33916991248;7565.394768418623;7702.922970770444;8599.914000859912;8924.821503569763;9215.124563166488;32828;33272.33455330928;33361.33277334488;33866.66133338635;33981.66018339884;42531.3620295702;43232.78383608062;44015;45550.54449455596;45680.54319456763;9721.319507634398;9785.657501987396;11135.610253641084;11230.83153752678;11626.418679066182;11055.391953442639;11063.280886742335;11139.554417823196;11752.471138798604;11923.10576706733;10498.370097794157;10758.784824303626;10981.725456863642;11309.817771858123;11915.761684766083;11069.83395249088;11315.660530184108;11478.081753459535;11790.41047947582;12063.034957203578;11121.83317250258;11155.16336274799;11388.088952883914;11554.075673946232;11624.418779061183;8367.213897915615;8540.40217184791;8648.43785153963;8651.913480865363;8965.282777377664;7982.92017079845;8095.797605059921;8250.711225107092;8471.152884711479;8593.613287402208 06:19:48 INFO - PROCESS | 5191 | __end_tp_report 06:19:48 INFO - PROCESS | 5191 | __start_cc_report 06:19:48 INFO - PROCESS | 5191 | _x_x_mozilla_cycle_collect,966 06:19:48 INFO - PROCESS | 5191 | __end_cc_report 06:19:48 INFO - PROCESS | 5191 | __startTimestamp1453040388340__endTimestamp 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | ------- Summary: start ------- 06:19:48 INFO - PROCESS | 5191 | Number of tests: 6 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#0] dojo.html Cycles:165 Average:5139.28 Median:5302.68 stddev:544.97 (10.3%) stddev-sans-first:523.72 06:19:48 INFO - PROCESS | 5191 | Values: 3145.8 3175.6 3219.9 3221.8 3231.6 5078.3 5172.8 5181.6 5188.9 5204.3 5109.8 5186.8 5194.3 5213.3 5262.3 4730.5 4734.8 4753.9 4768.1 4771.4 4803.3 4841.4 4866.2 4888.5 4909.7 4561.4 4635.5 4659.2 4720.8 4766.5 4641.9 4740.4 4753.9 4761.8 4766.4 4652.1 4662.0 4674.9 4679.3 4705.5 4943.3 4960.6 5004.9 5034.4 5066.1 5449.7 5467.4 5471.4 5471.8 5472.1 5431.7 5437.3 5456.9 5488.2 5500.5 5057.6 5078.7 5082.5 5138.9 5143.6 5672.6 5694.0 5696.9 5711.0 5720.1 5367.6 5449.1 5467.6 5477.5 5492.5 5369.4 5523.3 5574.6 5578.5 5592.6 5531.3 5571.6 5578.3 5578.4 5580.5 5521.0 5545.5 5564.9 5566.1 5574.9 4224.0 4295.9 4304.3 4340.1 4377.0 3859.7 3860.3 3880.5 3898.5 3922.4 5157.4 5162.1 5170.9 5174.7 5215.0 5334.6 5417.0 5469.7 5516.2 5535.0 5067.8 5070.1 5106.7 5124.3 5140.2 4739.7 4739.7 4743.1 4746.5 4782.8 5609.6 5706.3 5724.4 5800.9 5813.0 5469.2 5506.9 5507.1 5509.8 5517.1 5728.1 5736.1 5740.5 5741.9 5749.0 5313.9 5340.2 5363.5 5418.6 5460.5 5575.1 5590.4 5597.0 5599.0 5600.1 5285.6 5447.0 5467.3 5480.3 5515.6 5344.7 5390.1 5390.5 5446.8 5494.3 5253.2 5295.4 5297.2 5299.0 5302.7 5423.7 5427.5 5455.8 5459.0 5480.4 5241.3 5302.7 5313.2 5320.2 5359.0 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#1] ext.html Cycles:180 Average:44627.50 Median:19864.90 stddev:73508.85 (370.0%) stddev-sans-first:73640.48 06:19:48 INFO - PROCESS | 5191 | Values: 525.4 531.1 539.8 557.3 560.9 29420.6 29809.4 29825.3 29860.4 29866.3 37221.4 37868.4 37899.2 37932.8 37984.3 8419.8 8595.3 8595.4 8603.8 8605.4 8318.3 8485.2 8486.4 8486.5 8487.0 8453.5 8534.8 8543.6 8550.5 8550.6 8421.8 8509.4 8511.3 8512.1 8516.7 8377.6 8413.3 8607.0 8627.5 8627.7 35983.6 36304.5 36366.5 38791.2 39092.6 3270.0 3282.4 3427.0 3578.9 3600.5 26522.5 27193.0 27227.9 27306.0 27349.6 3787.3 3841.3 3908.5 3954.3 3971.3 273520.0 278697.0 278865.0 279267.0 279539.0 59086.7 60323.0 60348.0 60425.7 60548.4 64048.7 64333.0 64715.7 64734.4 64779.4 14338.1 14463.7 14467.3 14529.3 14565.1 10891.8 10943.8 10968.6 10976.2 10981.7 19414.9 20234.8 20241.3 20285.0 20298.5 7815.6 7904.7 8016.6 8039.6 8078.6 786.7 911.0 965.8 975.8 1047.6 25369.2 25760.4 25847.0 25972.0 26008.1 974.2 977.3 1045.5 1051.5 1121.3 13964.7 14071.8 14215.1 14260.1 14561.8 307760.0 315505.0 315807.0 316031.0 316964.0 46865.8 48000.5 49699.3 50777.7 51403.5 1258.2 1272.9 1275.9 1285.8 1320.3 25887.9 26490.9 27899.3 27977.3 28604.9 46122.5 46641.0 46724.3 46731.5 46731.8 244556.0 247212.0 247449.0 247482.0 247593.0 32521.5 32908.3 33144.8 33329.8 33367.3 42171.0 43173.8 43626.8 43758.1 44164.8 36400.0 36452.8 36676.6 37427.4 38116.0 35611.8 36129.3 37007.4 37154.6 37222.8 30073.0 30681.4 30686.4 30727.8 31287.0 32289.4 33004.2 33571.5 33626.2 33636.0 25501.0 26272.6 26289.9 26333.0 26699.9 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#2] jquery.html Cycles:180 Average:22675.20 Median:21520.27 stddev:60462.84 (281.0%) stddev-sans-first:60609.23 06:19:48 INFO - PROCESS | 5191 | Values: 356.1 360.3 360.9 365.1 367.8 13761.0 13836.0 15805.4 16905.0 18237.3 10152.4 10512.8 16437.1 16954.3 17027.1 4848.2 5009.8 5010.0 5011.0 5012.7 3678.5 3823.1 4931.6 4977.5 6543.8 6516.2 6813.9 6856.0 6856.3 6858.1 6519.9 6539.1 6568.9 6578.5 6578.6 6206.0 6532.5 6551.0 6555.2 6555.4 20258.9 21912.7 22719.5 22959.9 22961.2 2050.6 2081.3 2116.2 2153.5 2161.1 11878.8 13306.8 13615.7 13690.5 13917.5 1721.8 1876.8 1890.9 1947.5 1960.9 64338.0 65191.7 65905.7 66226.3 66542.7 9669.8 9753.8 9839.5 9959.2 10044.9 12927.9 13134.0 13134.3 13139.5 13145.5 6782.3 6798.4 7012.0 7057.6 7233.3 6553.9 6562.3 6582.7 6729.2 6813.7 4040.3 4361.2 4363.8 4408.1 4495.5 1722.0 1762.1 1792.8 1794.5 1795.5 441.6 452.5 824.0 1004.5 1028.2 10028.8 10556.6 10720.5 10765.7 10845.9 418.2 442.1 459.7 477.0 488.1 5779.1 5940.5 5941.9 5998.9 6032.8 345387.0 366808.0 370256.0 371790.0 381055.0 54855.2 66196.1 70802.3 74888.6 75296.0 1125.3 1125.4 1150.3 1160.3 1168.4 13678.5 14292.1 14582.3 15174.4 15444.7 32546.3 32643.3 33601.7 33777.8 33848.5 39217.4 39909.4 41043.4 41657.4 42155.6 7339.3 7435.9 7474.9 7509.3 7601.8 8530.6 11166.3 11405.8 11468.2 11587.4 9361.1 9480.0 9538.3 9962.5 10294.4 9811.3 9918.0 10285.7 10299.9 10330.0 8068.8 10037.5 10254.2 10257.3 10511.6 7394.7 7589.9 7598.5 7628.0 7651.2 9661.7 10083.8 10094.9 10201.1 10253.0 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#3] mootools.html Cycles:180 Average:5594.97 Median:6700.11 stddev:2888.86 (43.1%) stddev-sans-first:2879.01 06:19:48 INFO - PROCESS | 5191 | Values: 1310.2 1487.8 1494.9 1664.9 1808.9 7141.7 7598.5 7766.5 7775.3 7777.8 7776.1 7785.3 7939.9 7978.7 7985.7 2021.3 2072.2 2301.1 2365.2 2398.0 2348.2 2351.8 2355.8 2358.7 2361.4 2298.6 2370.5 2371.0 2371.3 2374.7 2257.8 2288.6 2333.3 2333.8 2340.0 2306.9 2307.1 2334.9 2339.7 2376.1 7900.3 7934.0 7942.4 7991.6 8017.6 4819.3 4925.0 4957.0 4967.2 4977.2 3180.8 3291.3 3297.1 3300.4 3355.3 1015.4 1015.7 1051.0 1057.6 1072.8 11346.8 11362.9 11367.5 11388.3 11388.8 4532.1 4601.8 4611.3 4613.6 4638.6 9423.0 9456.5 9458.3 9462.2 9579.4 4955.5 4983.1 4983.8 4986.8 4992.4 4452.2 4481.7 4482.1 4489.8 4499.3 3403.7 3457.7 3465.0 3661.3 3735.3 1197.2 1199.6 1210.9 1212.4 1220.1 1079.3 1100.7 1102.3 1240.6 1370.7 7322.6 7415.2 7472.9 7489.0 7521.8 1105.5 1111.5 1112.7 1113.0 1142.8 5838.3 5942.5 5956.1 6024.4 6032.3 9178.1 9458.7 9560.3 9616.1 9737.5 9364.2 9484.5 9485.7 9576.8 9600.1 7151.7 7247.8 7273.6 7374.2 7386.8 7357.1 7428.3 7434.2 7448.3 7451.3 8058.5 8286.0 8378.1 8476.4 8572.9 8492.5 8567.9 8730.7 8754.3 8760.9 6734.4 6915.7 7008.1 7058.0 7059.6 6952.2 7097.0 7360.1 7594.5 7611.4 6932.2 7159.0 7204.4 7250.9 7263.3 7085.6 7138.5 7145.7 7232.6 7359.8 7247.1 7293.5 7298.0 7332.2 7351.0 6733.2 6775.1 6798.3 6799.3 6810.7 6682.7 6717.5 6754.8 6758.6 6791.8 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#4] prototype.html Cycles:180 Average:5128.78 Median:5770.61 stddev:1509.09 (26.2%) stddev-sans-first:1469.99 06:19:48 INFO - PROCESS | 5191 | Values: 345.5 356.2 357.3 359.4 361.2 5581.4 5744.8 5768.7 5807.7 5821.6 5601.8 5660.4 5715.9 5727.2 5754.8 4413.5 4448.3 4462.8 4481.5 4500.0 4261.2 4379.9 4483.4 4500.5 4505.2 4172.7 4302.5 4337.3 4343.2 4445.3 4433.7 4435.8 4468.4 4478.4 4491.6 3954.7 3984.1 3984.8 3995.2 3998.8 5522.6 5528.5 5532.0 5536.5 5552.9 5069.5 5140.5 5141.1 5179.2 5192.6 6033.9 6046.0 6048.6 6054.1 6056.5 4318.2 4326.6 4332.1 4335.4 4340.0 6037.5 6175.8 6216.3 6356.1 6362.6 4471.0 4492.5 4494.8 4511.3 4520.3 4562.6 4565.4 4567.3 4571.1 4571.1 5038.5 5158.7 5173.2 5176.1 5176.3 6098.5 6101.2 6114.1 6116.0 6125.7 1596.2 1607.7 1609.1 1611.6 1612.8 1076.1 1096.6 1103.9 1108.4 1117.3 5762.7 5772.6 5776.3 5785.1 5786.3 6239.8 6247.3 6254.0 6255.2 6265.9 5761.5 5765.2 5773.0 5776.7 5783.0 3260.5 3368.2 3371.3 3376.2 3376.7 6487.5 6493.9 6503.2 6514.0 6561.0 6373.2 6385.3 6397.4 6398.6 6441.2 6323.7 6481.8 6538.6 6559.8 6568.2 6256.6 6260.5 6261.3 6262.1 6263.7 5995.7 6168.3 6181.3 6187.1 6190.4 6383.1 6469.9 6516.5 6579.1 6609.7 4529.9 4537.9 4538.3 4541.1 4549.6 6039.6 6133.3 6188.3 6327.2 6336.2 6130.0 6136.5 6164.4 6179.2 6194.7 6094.1 6103.4 6109.3 6163.5 6171.5 5904.5 5990.8 5997.9 6053.9 6115.0 6208.1 6237.3 6251.9 6330.0 6332.1 6054.7 6066.6 6095.0 6097.8 6099.3 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - PROCESS | 5191 | [#5] yui.html Cycles:180 Average:13008.51 Median:46592.03 stddev:14942.67 (32.1%) stddev-sans-first:14955.92 06:19:48 INFO - PROCESS | 5191 | Values: 684.2 714.7 752.3 752.4 834.1 12966.4 13040.5 13110.3 13153.8 13160.0 12382.1 12438.1 12452.7 12871.4 13229.3 763.1 780.9 782.2 783.1 783.4 773.7 774.6 775.4 775.9 776.1 810.3 811.4 812.6 813.6 813.9 811.9 812.1 812.2 813.1 813.7 594.6 595.2 595.3 597.0 597.4 12053.2 12141.0 12171.9 12176.6 12220.9 10932.6 11008.1 11051.6 11084.5 11418.2 9375.7 9451.1 9489.2 9533.7 9762.4 3528.1 3591.3 3596.4 3602.5 3671.9 44979.0 44991.3 45048.3 45179.0 45282.8 8571.9 8604.7 8618.9 8779.4 8836.6 16070.2 16143.4 16173.7 16189.3 16194.3 7536.2 7540.8 7782.4 7857.8 7894.2 4234.9 4252.9 4347.8 4364.5 4411.4 3093.7 3148.7 3156.0 3163.7 3176.5 550.0 562.2 569.0 571.0 574.1 512.5 522.5 535.2 585.0 657.9 8092.2 8294.6 8412.2 8450.6 8805.0 656.2 657.5 659.7 679.7 692.0 3801.3 3858.8 4079.8 4156.5 4188.8 53553.0 53982.0 54149.0 54481.0 54594.5 44563.8 45124.8 45299.8 47503.5 48534.0 41974.7 42072.6 42275.9 43988.0 44055.3 7565.4 7702.9 8599.9 8924.8 9215.1 32828.0 33272.3 33361.3 33866.7 33981.7 42531.4 43232.8 44015.0 45550.5 45680.5 9721.3 9785.7 11135.6 11230.8 11626.4 11055.4 11063.3 11139.6 11752.5 11923.1 10498.4 10758.8 10981.7 11309.8 11915.8 11069.8 11315.7 11478.1 11790.4 12063.0 11121.8 11155.2 11388.1 11554.1 11624.4 8367.2 8540.4 8648.4 8651.9 8965.3 7982.9 8095.8 8250.7 8471.2 8593.6 06:19:48 INFO - PROCESS | 5191 | -------- Summary: end -------- 06:19:48 INFO - PROCESS | 5191 | 06:19:48 INFO - TEST-INFO | 5191: exit 0 06:19:48 INFO - TEST-OK | dromaeo_css | took 1113377ms 06:19:48 INFO - TEST-START | kraken 06:19:48 INFO - operating with platform_type : linux_ 06:19:48 INFO - Initialising browser for kraken test... 06:19:48 INFO - TEST-INFO | started process 5394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYBRfVg/profile http://localhost:43621/getInfo.html) 06:19:52 INFO - PROCESS | 5394 | __metrics Screen width/height:1600/1200 06:19:52 INFO - PROCESS | 5394 | colorDepth:24 06:19:52 INFO - PROCESS | 5394 | Browser inner width/height: 1024/697 06:19:52 INFO - PROCESS | 5394 | __metrics 06:19:52 INFO - PROCESS | 5394 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:19:52 INFO - PROCESS | 5394 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:19:53 INFO - TEST-INFO | 5394: exit 0 06:19:53 INFO - Browser initialized. 06:19:53 INFO - Running cycle 1/1 for kraken test... 06:19:53 INFO - TEST-INFO | started process 5477 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYBRfVg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:05 INFO - PROCESS | 5477 | RSS: Main: 150126592 06:20:05 INFO - PROCESS | 5477 | 06:20:08 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43621/tests/kraken/driver.html?testName=audio-beat-detection) 06:20:08 INFO - PROCESS | 5477 | RSS: Main: 185495552 06:20:08 INFO - PROCESS | 5477 | 06:20:11 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43621/tests/kraken/driver.html?testName=audio-dft) 06:20:11 INFO - PROCESS | 5477 | RSS: Main: 176615424 06:20:11 INFO - PROCESS | 5477 | 06:20:14 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43621/tests/kraken/driver.html?testName=audio-fft) 06:20:15 INFO - PROCESS | 5477 | RSS: Main: 161071104 06:20:15 INFO - PROCESS | 5477 | 06:20:17 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43621/tests/kraken/driver.html?testName=audio-oscillator) 06:20:18 INFO - PROCESS | 5477 | RSS: Main: 163065856 06:20:18 INFO - PROCESS | 5477 | 06:20:20 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:20:20 INFO - PROCESS | 5477 | RSS: Main: 164458496 06:20:20 INFO - PROCESS | 5477 | 06:20:23 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43621/tests/kraken/driver.html?testName=imaging-darkroom) 06:20:24 INFO - PROCESS | 5477 | RSS: Main: 166416384 06:20:24 INFO - PROCESS | 5477 | 06:20:27 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43621/tests/kraken/driver.html?testName=imaging-desaturate) 06:20:28 INFO - PROCESS | 5477 | RSS: Main: 165617664 06:20:28 INFO - PROCESS | 5477 | 06:20:31 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43621/tests/kraken/driver.html?testName=json-parse-financial) 06:20:31 INFO - PROCESS | 5477 | RSS: Main: 165003264 06:20:31 INFO - PROCESS | 5477 | 06:20:33 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:33 INFO - PROCESS | 5477 | RSS: Main: 175112192 06:20:33 INFO - PROCESS | 5477 | 06:20:35 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:36 INFO - PROCESS | 5477 | RSS: Main: 171749376 06:20:36 INFO - PROCESS | 5477 | 06:20:38 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:38 INFO - PROCESS | 5477 | RSS: Main: 182521856 06:20:38 INFO - PROCESS | 5477 | 06:20:41 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:41 INFO - PROCESS | 5477 | RSS: Main: 189579264 06:20:41 INFO - PROCESS | 5477 | 06:20:44 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:44 INFO - PROCESS | 5477 | RSS: Main: 188776448 06:20:44 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | Cycle 1(1): loaded http://localhost:43621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43621/tests/kraken/driver.html?testName=ai-astar) 06:20:46 INFO - PROCESS | 5477 | RSS: Main: 246845440 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | __start_tp_report 06:20:46 INFO - PROCESS | 5477 | _x_x_mozilla_page_load 06:20:46 INFO - PROCESS | 5477 | _x_x_mozilla_page_load_details 06:20:46 INFO - PROCESS | 5477 | |i|pagename|runs| 06:20:46 INFO - PROCESS | 5477 | |0;ai-astar;108;111;105;109;111;110;100;109;109;110 06:20:46 INFO - PROCESS | 5477 | |1;audio-beat-detection;155;135;148;173;127;150;156;125;173;134 06:20:46 INFO - PROCESS | 5477 | |2;audio-dft;165;161;161;161;163;162;162;161;163;161 06:20:46 INFO - PROCESS | 5477 | |3;audio-fft;74;71;97;100;71;72;73;120;98;72 06:20:46 INFO - PROCESS | 5477 | |4;audio-oscillator;97;98;144;104;96;96;153;96;98;136 06:20:46 INFO - PROCESS | 5477 | |5;imaging-gaussian-blur;111;110;108;109;110;110;109;110;109;110 06:20:46 INFO - PROCESS | 5477 | |6;imaging-darkroom;147;145;146;145;145;146;146;147;146;146 06:20:46 INFO - PROCESS | 5477 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;95 06:20:46 INFO - PROCESS | 5477 | |8;json-parse-financial;67;57;56;55;56;57;56;65;55;56 06:20:46 INFO - PROCESS | 5477 | |9;json-stringify-tinderbox;68;67;67;68;68;68;68;68;67;68 06:20:46 INFO - PROCESS | 5477 | |10;stanford-crypto-aes;90;91;83;82;83;83;82;83;88;83 06:20:46 INFO - PROCESS | 5477 | |11;stanford-crypto-ccm;116;112;114;124;112;113;123;115;117;114 06:20:46 INFO - PROCESS | 5477 | |12;stanford-crypto-pbkdf2;141;134;142;139;152;138;140;139;144;142 06:20:46 INFO - PROCESS | 5477 | |13;stanford-crypto-sha256-iterative;66;66;67;66;67;65;65;67;66;66 06:20:46 INFO - PROCESS | 5477 | __end_tp_report 06:20:46 INFO - PROCESS | 5477 | __start_cc_report 06:20:46 INFO - PROCESS | 5477 | _x_x_mozilla_cycle_collect,975 06:20:46 INFO - PROCESS | 5477 | __end_cc_report 06:20:46 INFO - PROCESS | 5477 | __startTimestamp1453040446693__endTimestamp 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | ------- Summary: start ------- 06:20:46 INFO - PROCESS | 5477 | Number of tests: 14 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#0] ai-astar Cycles:10 Average:108.20 Median:109.50 stddev:3.36 (3.1%) stddev-sans-first:3.56 06:20:46 INFO - PROCESS | 5477 | Values: 108.0 111.0 105.0 109.0 111.0 110.0 100.0 109.0 109.0 110.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:152.50 stddev:17.32 (11.4%) stddev-sans-first:18.16 06:20:46 INFO - PROCESS | 5477 | Values: 155.0 135.0 148.0 173.0 127.0 150.0 156.0 125.0 173.0 134.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:0.87 06:20:46 INFO - PROCESS | 5477 | Values: 165.0 161.0 161.0 161.0 163.0 162.0 162.0 161.0 163.0 161.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#3] audio-fft Cycles:10 Average:84.80 Median:72.50 stddev:17.50 (24.1%) stddev-sans-first:18.12 06:20:46 INFO - PROCESS | 5477 | Values: 74.0 71.0 97.0 100.0 71.0 72.0 73.0 120.0 98.0 72.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:96.00 stddev:22.92 (23.9%) stddev-sans-first:23.68 06:20:46 INFO - PROCESS | 5477 | Values: 97.0 98.0 144.0 104.0 96.0 96.0 153.0 96.0 98.0 136.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.84 (0.8%) stddev-sans-first:0.73 06:20:46 INFO - PROCESS | 5477 | Values: 111.0 110.0 108.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 06:20:46 INFO - PROCESS | 5477 | Values: 147.0 145.0 146.0 145.0 145.0 146.0 146.0 147.0 146.0 146.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:20:46 INFO - PROCESS | 5477 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:56.50 stddev:4.29 (7.6%) stddev-sans-first:3.08 06:20:46 INFO - PROCESS | 5477 | Values: 67.0 57.0 56.0 55.0 56.0 57.0 56.0 65.0 55.0 56.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 06:20:46 INFO - PROCESS | 5477 | Values: 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:3.46 (4.2%) stddev-sans-first:3.11 06:20:46 INFO - PROCESS | 5477 | Values: 90.0 91.0 83.0 82.0 83.0 83.0 82.0 83.0 88.0 83.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:115.50 stddev:4.27 (3.7%) stddev-sans-first:4.53 06:20:46 INFO - PROCESS | 5477 | Values: 116.0 112.0 114.0 124.0 112.0 113.0 123.0 115.0 117.0 114.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:141.50 stddev:4.70 (3.3%) stddev-sans-first:4.99 06:20:46 INFO - PROCESS | 5477 | Values: 141.0 134.0 142.0 139.0 152.0 138.0 140.0 139.0 144.0 142.0 06:20:46 INFO - PROCESS | 5477 | 06:20:46 INFO - PROCESS | 5477 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 06:20:46 INFO - PROCESS | 5477 | Values: 66.0 66.0 67.0 66.0 67.0 65.0 65.0 67.0 66.0 66.0 06:20:46 INFO - PROCESS | 5477 | -------- Summary: end -------- 06:20:46 INFO - PROCESS | 5477 | 06:20:47 INFO - TEST-INFO | 5477: exit 0 06:20:47 INFO - TEST-OK | kraken | took 58653ms 06:20:47 INFO - TEST-START | v8_7 06:20:47 INFO - operating with platform_type : linux_ 06:20:47 INFO - Initialising browser for v8_7 test... 06:20:47 INFO - TEST-INFO | started process 5728 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0UrpRW/profile http://localhost:43621/getInfo.html) 06:20:51 INFO - PROCESS | 5728 | __metrics Screen width/height:1600/1200 06:20:51 INFO - PROCESS | 5728 | colorDepth:24 06:20:51 INFO - PROCESS | 5728 | Browser inner width/height: 1024/697 06:20:51 INFO - PROCESS | 5728 | __metrics 06:20:51 INFO - PROCESS | 5728 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:20:51 INFO - PROCESS | 5728 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:20:52 INFO - TEST-INFO | 5728: exit 0 06:20:52 INFO - Browser initialized. 06:20:52 INFO - Running cycle 1/1 for v8_7 test... 06:20:52 INFO - TEST-INFO | started process 5809 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0UrpRW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:04 INFO - PROCESS | 5809 | RSS: Main: 150253568 06:21:04 INFO - PROCESS | 5809 | 06:21:26 INFO - PROCESS | 5809 | Cycle 1(1): loaded http://localhost:43621/tests/v8_7/run.html (next: http://localhost:43621/tests/v8_7/run.html) 06:21:27 INFO - PROCESS | 5809 | RSS: Main: 557092864 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | __start_tp_report 06:21:27 INFO - PROCESS | 5809 | _x_x_mozilla_page_load 06:21:27 INFO - PROCESS | 5809 | _x_x_mozilla_page_load_details 06:21:27 INFO - PROCESS | 5809 | |i|pagename|runs| 06:21:27 INFO - PROCESS | 5809 | |0;Richards;168.6056314280897 06:21:27 INFO - PROCESS | 5809 | |1;DeltaBlue;196.27085377821393 06:21:27 INFO - PROCESS | 5809 | |2;Encrypt;284.57598178713715 06:21:27 INFO - PROCESS | 5809 | |3;Decrypt;5175.257731958763 06:21:27 INFO - PROCESS | 5809 | |4;RayTrace;1988.0715705765408 06:21:27 INFO - PROCESS | 5809 | |5;Earley;809.7165991902834 06:21:27 INFO - PROCESS | 5809 | |6;Boyer;12370.37037037037 06:21:27 INFO - PROCESS | 5809 | |7;RegExp;41795.91836734694 06:21:27 INFO - PROCESS | 5809 | |8;Splay;558.282208588957 06:21:27 INFO - PROCESS | 5809 | |9;NavierStokes;4859.223300970873 06:21:27 INFO - PROCESS | 5809 | __end_tp_report 06:21:27 INFO - PROCESS | 5809 | __startTimestamp1453040487104__endTimestamp 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | ------- Summary: start ------- 06:21:27 INFO - PROCESS | 5809 | Number of tests: 10 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#0] Richards Cycles:1 Average:168.61 Median:168.61 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 168.6 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#1] DeltaBlue Cycles:1 Average:196.27 Median:196.27 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 196.3 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#2] Encrypt Cycles:1 Average:284.58 Median:284.58 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 284.6 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 5175.3 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 1988.1 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 809.7 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 12370.4 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#7] RegExp Cycles:1 Average:41795.92 Median:41795.92 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 41795.9 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#8] Splay Cycles:1 Average:558.28 Median:558.28 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 558.3 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - PROCESS | 5809 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 06:21:27 INFO - PROCESS | 5809 | Values: 4859.2 06:21:27 INFO - PROCESS | 5809 | -------- Summary: end -------- 06:21:27 INFO - PROCESS | 5809 | 06:21:27 INFO - TEST-INFO | 5809: exit 0 06:21:28 INFO - TEST-OK | v8_7 | took 40437ms 06:21:28 INFO - SUITE-END | took 1212s 06:21:28 INFO - Completed test suite (00:20:12) 06:21:28 INFO - Working with test: dromaeo_css 06:21:28 INFO - Generating results file: dromaeo_css 06:21:28 INFO - Working with test: kraken 06:21:28 INFO - Generating results file: kraken 06:21:28 INFO - javascript benchmark 06:21:28 INFO - Working with test: v8_7 06:21:28 INFO - Generating results file: v8_7 06:21:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 06:21:28 INFO - process_Request line: dromaeo_css 6716.41 graph.html#tests=[[72,1,35]] 06:21:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:28 INFO - process_Request line: kraken 1499.40 graph.html#tests=[[232,1,35]] 06:21:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:21:28 INFO - process_Request line: v8_7 18873.50 graph.html#tests=[[230,1,35]] 06:21:28 INFO - RETURN: dromaeo_css: 6716.41 06:21:28 INFO - RETURN: kraken: 1499.40 06:21:28 INFO - RETURN: v8_7: 18873.50 06:21:28 INFO - javascript benchmark 06:21:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3145.795523290986, 3175.571297874786, 3219.871205151794, 3221.822799746014, 3231.5798946136997, 5078.263651770491, 5172.793088276464, 5181.5854731621475, 5188.922166167506, 5204.32343795306, 5109.821156259532, 5186.7925282988635, 5194.298769666094, 5213.348331458567, 5262.315898933143, 4730.479647238801, 4734.763261836912, 4753.90492190156, 4768.117898188846, 4771.379720636312, 4803.327534145223, 4841.394825646794, 4866.197077482211, 4888.535589119028, 4909.705417674933, 4561.429821272324, 4635.490096089427, 4659.161350956826, 4720.787564559569, 4766.451858036318, 4641.883952901205, 4740.360051393052, 4753.906601481644, 4761.8095276188915, 4766.356541866839, 4652.092841895832, 4662.0, 4674.859754207379, 4679.27471241958, 4705.505921878222, 4943.307936888838, 4960.627952903546, 5004.923941352627, 5034.395872495324, 5066.06277838601, 5449.700266485342, 5467.398586155519, 5471.398146203915, 5471.8084867029465, 5472.124460086367, 5431.728413579344, 5437.265969094161, 5456.91814622781, 5488.204210389471, 5500.532454741352, 5057.570106540912, 5078.7460626968505, 5082.542571168576, 5138.948610513922, 5143.5627971622835, 5672.574556908248, 5694.0, 5696.8860622787315, 5711.0, 5720.11338242573, 5367.570594352443, 5449.128139497661, 5467.644603100865, 5477.534409575151, 5492.47821456961, 5369.4362091980565, 5523.337199536081, 5574.581906356958, 5578.470045345685, 5592.552595792326, 5531.308586426697, 5571.554275657938, 5578.330600327987, 5578.44215578447, 5580.469855363734, 5521.0, 5545.528630066409, 5564.888702225933, 5566.081596536607, 5574.86062848432, 4223.957760422418, 4295.892602684896, 4304.311310190355, 4340.066885619607, 4377.037051848588, 3859.6526312632, 3860.343741563941, 3880.4567360569545, 3898.493195884517, 3922.3920292354733, 5157.432682405008, 5162.1224391853475, 5170.870728231825, 5174.715390653475, 5214.983078299771, 5334.599905007062, 5416.972915135478, 5469.726513674301, 5516.172574113915, 5534.972325138348, 5067.771950262247, 5070.138076527, 5106.744662766847, 5124.30821839047, 5140.151874940668, 4739.691920025188, 4739.715617062987, 4743.146233677902, 4746.477887432379, 4782.832600858953, 5609.551235901118, 5706.315242170883, 5724.370319264877, 5800.941990580124, 5813.040848260159, 5469.15228139639, 5506.944930550643, 5507.118860982224, 5509.779608815603, 5517.062099443024, 5728.140778883201, 5736.053551164011, 5740.454656807597, 5741.885162296814, 5749.0, 5313.920291195558, 5340.225667278145, 5363.463653634762, 5418.566514678895, 5460.535854452257, 5575.135853942646, 5590.413006634245, 5596.972015139898, 5598.972005139948, 5600.131979543177, 5285.550728188147, 5446.972765136149, 5467.261919640957, 5480.342358916955, 5515.586331025109, 5344.679319240858, 5390.110631745875, 5390.4879036491475, 5446.836594902159, 5494.2582751328055, 5253.23828044939, 5295.417504074471, 5297.17893726473, 5299.0, 5302.655327403706, 5423.674579525241, 5427.48438898304, 5455.809046683347, 5458.972705136449, 5480.3971563127225, 5241.31862857826, 5302.681839089667, 5313.1764576490705, 5320.201969704575, 5359.035373632628], "unit": "score", "name": "dojo.html", "value": 5105.983763674982}, {"lowerIsBetter": false, "replicates": [525.398418810462, 531.0679757026415, 539.8380485854245, 557.2504980800823, 560.9074502707053, 29420.558691619615, 29809.40381192375, 29825.254368640795, 29860.402791944176, 29866.25334366642, 37221.44167837478, 37868.43197352035, 37899.24201515968, 37932.810335948285, 37984.341096123215, 8419.789505262386, 8595.312375009984, 8595.355348348867, 8603.827923441528, 8605.39762216645, 8318.334533237357, 8485.193906578865, 8486.448380855256, 8486.490810551355, 8486.957565212166, 8453.45052571584, 8534.829303413928, 8543.57282135894, 8550.486970781772, 8550.572471376438, 8421.789455263637, 8509.361797865124, 8511.319094472488, 8512.063672995966, 8516.70191543293, 8377.6230069647, 8413.326933845277, 8606.956965215197, 8627.525486098262, 8627.6980305689, 35983.64016359855, 36304.45543316852, 36366.454503182475, 38791.224175516334, 39092.60907390918, 3270.049522146034, 3282.3599398117376, 3426.9657303427143, 3578.874739384135, 3600.531930848999, 26522.469550609072, 27193.04824331139, 27227.86386068077, 27306.0, 27349.589756153673, 3787.299349620329, 3841.3277676406797, 3908.4528166056775, 3954.3475326571083, 3971.2653159165648, 273520.0, 278697.0, 278865.0, 279267.0, 279539.0, 59086.704566476896, 60323.0, 60348.0, 60425.69787151124, 60548.39451605516, 64048.67975660092, 64333.0, 64715.67642161853, 64734.35265647378, 64779.352206477335, 14338.139711617336, 14463.710725785426, 14467.348969296196, 14529.273536323142, 14565.126092434488, 10891.83662245067, 10943.781124377469, 10968.616098436676, 10976.176786741027, 10981.670549883516, 19414.902925485283, 20234.79765202329, 20241.291554795513, 20285.0, 20298.492537686678, 7815.6482958267015, 7904.723334683258, 8016.599170041474, 8039.557824319601, 8078.636461359253, 786.7089177004545, 910.9635614575475, 965.8406362950175, 975.7560609847538, 1047.607147319755, 25369.238922831977, 25760.355991100372, 25847.0, 25972.0, 26008.08971685982, 974.152487336008, 977.296346630425, 1045.5399624165343, 1051.5215576912487, 1121.327203677803, 13964.72070558583, 14071.788923166161, 14215.147091174562, 14260.144391336346, 14561.78157327641, 307760.0, 315505.0, 315807.0, 316031.0, 316964.0, 46865.76567117142, 48000.51999479961, 49699.254511182364, 50777.746111269946, 51403.485965140615, 1258.1947553565726, 1272.923624582528, 1275.8851703346559, 1285.774989376874, 1320.3002408723391, 25887.870560647076, 26490.86754566215, 27899.302517437227, 27977.300567485974, 28604.85697571499, 46122.53877461182, 46641.0, 46724.29913551368, 46731.53268467408, 46731.76634116808, 244556.0, 247212.0, 247449.0, 247482.0, 247593.0, 32521.512177317833, 32908.341833162725, 33144.83427582846, 33329.83335083309, 33367.33265334728, 42171.0, 43173.78413107914, 43626.78186609047, 43758.12483750371, 44164.77917610391, 36400.0, 36452.81773591115, 36676.63323366839, 37427.43858842174, 38116.0, 35611.82194089013, 36129.27741445209, 37007.444888327234, 37154.628453715115, 37222.813885930394, 30073.0, 30681.386372272875, 30686.386272274874, 30727.846360768053, 31287.0, 32289.35421291608, 33004.17489562684, 33571.49642755312, 33626.159346016546, 33636.0, 25501.0, 26272.60591091097, 26289.868550657124, 26333.0, 26699.866500667373], "unit": "score", "name": "ext.html", "value": 17862.471928601106}, {"lowerIsBetter": false, "replicates": [356.0937414280656, 360.3333832410042, 360.922401683638, 365.1473808656786, 367.8069013767773, 13760.967927405434, 13836.031477796532, 15805.367785288588, 16905.0, 18237.270509179634, 10152.441615711134, 10512.842307365396, 16437.09595972221, 16954.321827126932, 17027.148642567852, 4848.248521479159, 5009.799608015675, 5009.974950125263, 5011.0, 5012.72430016349, 3678.4850120983083, 3823.120682243086, 4931.605471562284, 4977.452480227172, 6543.770968016121, 6516.152900122977, 6813.9318606813795, 6855.965720171393, 6856.2800905904905, 6858.074159988412, 6519.93480065198, 6539.117219175398, 6568.9014664779825, 6578.539502234846, 6578.60528368297, 6205.968970155121, 6532.542722009462, 6551.0, 6555.213374395055, 6555.410013098844, 20258.898705506377, 21912.671309930363, 22719.545609087727, 22959.885200574055, 22961.196358127552, 2050.5796311756053, 2081.261152290945, 2116.216999710102, 2153.493928926701, 2161.059938926572, 11878.821817672742, 13306.80039799394, 13615.727685446236, 13690.452381904712, 13917.512887048904, 1721.7847769028872, 1876.7560217171817, 1890.914908829106, 1947.4547126804375, 1960.9411717648493, 64338.034929476096, 65191.674041629485, 65905.67047164781, 66226.33773662298, 66542.66728666374, 9669.758256043515, 9753.804923901624, 9839.508024598741, 9959.203263738884, 10044.895061543224, 12927.870721292855, 13134.014948878872, 13134.277614731282, 13139.54011609589, 13145.53990610324, 6782.253952065269, 6798.354156355138, 7012.0, 7057.611831349325, 7233.31283528064, 6553.901691474632, 6562.343765623495, 6582.703778329987, 6729.158855143107, 6813.659317034128, 4040.313146765057, 4361.193179261847, 4363.825446982085, 4408.140412619508, 4495.527969563214, 1722.0442654326719, 1762.1365530890027, 1792.7948623193545, 1794.4616615015443, 1795.524186090687, 441.56505841745854, 452.47738861614886, 823.950562966224, 1004.5278719002057, 1028.1517747858047, 10028.849567256497, 10556.630517931835, 10720.517576709066, 10765.677029689123, 10845.945770271099, 418.20749679358056, 442.1113561740924, 459.6598517097324, 476.97853596587544, 488.0799692579513, 5779.104238842986, 5940.4653581177035, 5941.910871336933, 5998.880022399528, 6032.788852390146, 345387.0, 366808.0, 370256.0, 371790.0, 381055.0, 54855.177172342446, 66196.05647322352, 70802.29197707957, 74888.62555687295, 75296.0, 1125.3079356196045, 1125.4035361258382, 1150.344303746873, 1160.2748282323548, 1168.404113901899, 13678.452861885811, 14292.069236113524, 14582.270886455846, 15174.393024278905, 15444.691106178037, 32546.349073018882, 32643.34713305673, 33601.66398335985, 33777.83111084429, 33848.49227261642, 39217.411738824514, 39909.401358979056, 41043.384349235384, 41657.37513937233, 42155.57844421516, 7339.302766237199, 7435.859114233092, 7474.869662146262, 7509.286617771303, 7601.809954751176, 8530.573471326285, 11166.330020198815, 11405.828912566483, 11468.197226194086, 11587.362695051854, 9361.110694484014, 9480.0, 9538.284628653018, 9962.501874906371, 10294.3823370598, 9811.313208075366, 9918.0, 10285.691429257135, 10299.897001029894, 10330.018648228406, 8068.838623227385, 10037.49812509357, 10254.179665626882, 10257.28199026061, 10511.57953681844, 7394.704211831467, 7589.886151707839, 7598.506097103671, 7627.961860190663, 7651.234876512304, 9661.695671084313, 10083.848742268725, 10094.949525252327, 10201.132903703268, 10253.0], "unit": "score", "name": "jquery.html", "value": 7823.27792382672}, {"lowerIsBetter": false, "replicates": [1310.2007775257086, 1487.7917091607173, 1494.940202391904, 1664.9084300363475, 1808.8552915766732, 7141.678624461899, 7598.506097103691, 7766.456348055638, 7775.30022297993, 7777.766666999992, 7776.066871975357, 7785.26040026198, 7939.880901786478, 7978.680852765897, 7985.680572777096, 2021.2622392826586, 2072.2332736887374, 2301.056566807609, 2365.207655435431, 2397.976020239793, 2348.1898744933055, 2351.823613229015, 2355.7997570206553, 2358.705161854768, 2361.3506285771464, 2298.5517824024323, 2370.5140446208484, 2371.039728909794, 2371.312319427364, 2374.6675465434855, 2257.81937445004, 2288.599495088353, 2333.300009997011, 2333.778291062355, 2340.040583360831, 2306.850054746436, 2307.0541078157876, 2334.9182778602667, 2339.7075365579303, 2376.144587948337, 7900.32847207988, 7933.9603301983125, 7942.404319675989, 7991.640376183086, 8017.559034253114, 4819.325294458778, 4925.0, 4957.033378491195, 4967.205247160437, 4977.203647416396, 3180.761442891769, 3291.308825146722, 3297.093299342676, 3300.356430496054, 3355.2953879685297, 1015.4262841494532, 1015.6546774096843, 1050.9527071281811, 1057.5875408590655, 1072.8283474644097, 11346.773064538746, 11362.886371136265, 11367.545298188063, 11388.316700997966, 11388.772224555545, 4532.116237333688, 4601.792919318638, 4611.33135695329, 4613.63090952723, 4638.605718513964, 9423.01058388873, 9456.479893605918, 9458.290628202913, 9462.195713364441, 9579.425234485952, 4955.4796746341835, 4983.127952608352, 4983.750812459362, 4986.750662466935, 4992.350994370709, 4452.154090722753, 4481.708688935209, 4482.058767658828, 4489.820407183742, 4499.257622492252, 3403.7447191460737, 3457.7233821294235, 3464.995151406064, 3661.2860492203763, 3735.290294843971, 1197.233770386953, 1199.6401079676061, 1210.8728583498782, 1212.3877441891964, 1220.1398014399826, 1079.3469950679882, 1100.6753007862699, 1102.3385968418884, 1240.64021433785, 1370.712150448397, 7322.597257150801, 7415.221401752846, 7472.85054298911, 7488.9625551871895, 7521.811954701177, 1105.5467258424007, 1111.5387114347454, 1112.7218195451137, 1112.9554817807198, 1142.7771584540935, 5838.328592211865, 5942.494887934487, 5956.076808094752, 6024.367441418675, 6032.276126864716, 9178.082191780903, 9458.716238512856, 9560.330776845693, 9616.134547890724, 9737.513124343754, 9364.204042656314, 9484.525773711286, 9485.66800161991, 9576.76058098553, 9600.135987760996, 7151.749688760869, 7247.782566523013, 7273.599952002585, 7374.188839227788, 7386.778396648109, 7357.0803649543805, 7428.33145016951, 7434.182239953492, 7448.292412220831, 7451.2921272479025, 8058.476199047278, 8286.0, 8378.120297368689, 8476.364272679697, 8572.871406928776, 8492.532910689972, 8567.914320856711, 8730.650773969224, 8754.29965602763, 8760.868586971073, 6734.3602357775935, 6915.654217289216, 7008.0889484368745, 7057.964710176417, 7059.611721355374, 6952.235254121942, 7096.964515177391, 7360.07999000125, 7594.5063570867715, 7611.391088712779, 6932.23745388017, 7159.0, 7204.351608355273, 7250.89123663156, 7263.293126115253, 7085.574865508086, 7138.535995160298, 7145.678444470115, 7232.63836808147, 7359.8160045999275, 7247.13034435871, 7293.52592081513, 7298.0, 7332.156801967842, 7350.963245183953, 6733.225679046776, 6775.119234499483, 6798.252192258748, 6799.3200679931615, 6810.659467026728, 6682.699278532575, 6717.529772915849, 6754.797356079325, 6758.560693554903, 6791.796246112624], "unit": "score", "name": "mootools.html", "value": 4599.371741462194}, {"lowerIsBetter": false, "replicates": [345.53007909243433, 356.2163240870085, 357.324656399405, 359.4482469409457, 361.1765175400089, 5581.441855814416, 5744.79893203738, 5768.653880767157, 5807.73865176067, 5821.563382746301, 5601.80393686221, 5660.377358490563, 5715.914261286084, 5727.198192253088, 5754.827355179351, 4413.470383553978, 4448.28827387618, 4462.776861156945, 4481.5070342262325, 4499.977500112511, 4261.169072030955, 4379.934300985487, 4483.4171557697455, 4500.504944456107, 4505.234110201257, 4172.687048471362, 4302.48370195577, 4337.327714204288, 4343.153085148398, 4445.310976798602, 4433.733975961452, 4435.756033418177, 4468.419105516295, 4478.395416618748, 4491.550844915515, 3954.7033972451895, 3984.083660758042, 3984.820683069269, 3995.2409042281874, 3998.7800670963084, 5522.585806064521, 5528.530074943635, 5532.0, 5536.529395001429, 5552.944470555283, 5069.543741063285, 5140.511651393112, 5141.126008578551, 5179.223116532513, 5192.558632516203, 6033.909491357633, 6045.969770151165, 6048.60684055535, 6054.091886217103, 6056.5457590680435, 4318.244307246219, 4326.610605045561, 4332.1119170569955, 4335.436393268887, 4340.0, 6037.4566289033755, 6175.845603859894, 6216.316205217422, 6356.14192084072, 6362.5546211765195, 4471.038726673716, 4492.483364413069, 4494.752788596658, 4511.3458548510935, 4520.276755719069, 4562.608404436679, 4565.406497155349, 4567.337736028324, 4571.062932098912, 4571.131485017836, 5038.496150384932, 5158.742062896915, 5173.172292433268, 5176.094183517869, 5176.327077479904, 6098.451139397475, 6101.206843110367, 6114.144019837227, 6115.969420152871, 6125.693715314216, 1596.233807772276, 1607.6865011322914, 1609.0506601105403, 1611.5971007248188, 1612.7500237463212, 1076.05844885725, 1096.555894862582, 1103.8840921703106, 1108.3737688206138, 1117.312852595664, 5762.654240745569, 5772.5670574707065, 5776.277965254343, 5785.10330898703, 5786.334571524244, 6239.750409983641, 6247.344028876993, 6253.96873015632, 6255.186825712719, 6265.8746825063245, 5761.452661997104, 5765.164051212634, 5773.0, 5776.711164441761, 5782.971085144547, 3260.543523906655, 3368.208471009311, 3371.3088816792497, 3376.206591451007, 3376.679215474526, 6487.513436492282, 6493.928501797245, 6503.154589903283, 6513.990331498625, 6561.048647946117, 6373.235211774617, 6385.2656944451055, 6397.424231819158, 6398.584092034003, 6441.162648855712, 6323.652199129, 6481.805545833632, 6538.574992625559, 6559.8032059038305, 6568.211814582281, 6256.562040657111, 6260.467860231749, 6261.311255761953, 6262.123302737711, 6263.686815659108, 5995.730192141451, 6168.321484636776, 6181.258249009968, 6187.102870083902, 6190.380961903774, 6383.106365108982, 6469.902951455638, 6516.543841931209, 6579.078928949855, 6609.669516524251, 4529.909401812011, 4537.886552836206, 4538.341940418687, 4541.069080838354, 4549.613282870993, 6039.607425517327, 6133.294671112879, 6188.257409110935, 6327.17746692927, 6336.20797400325, 6129.969350153399, 6136.539759517965, 6164.4143806338325, 6179.165812615419, 6194.690265486617, 6094.08588711679, 6103.359147289649, 6109.2974307955155, 6163.476104530986, 6171.506279497539, 5904.468597826044, 5990.760369585168, 5997.940020599738, 6053.939460605337, 6114.960456722457, 6208.068789681584, 6237.251529816451, 6251.9062214067735, 6329.968350158219, 6332.145160403286, 6054.727537260922, 6066.605670631395, 6094.969525152524, 6097.7865774697675, 6099.3290738017895], "unit": "score", "name": "prototype.html", "value": 4652.098199950661}, {"lowerIsBetter": false, "replicates": [684.1960696181986, 714.678394722375, 752.2853289375095, 752.4206361101951, 834.1491678487943, 12966.351682415876, 13040.478380864777, 13110.34448277586, 13153.802692959602, 13160.0, 12382.133250672456, 12438.129330946836, 12452.688682782935, 12871.420786064626, 13229.272390018545, 763.0728664672408, 780.9414293927949, 782.1904329019466, 783.1033466680648, 783.385042741448, 773.6557232031748, 774.5507605588773, 775.4261846233803, 775.9185285545021, 776.0532150776072, 810.3112354498688, 811.4157806379427, 812.5693382507251, 813.6460639621754, 813.8697808350665, 811.9188081191893, 812.0945146162046, 812.2446125103651, 813.1015228172872, 813.7355359508153, 594.5986459140106, 595.2410676387597, 595.3451203675921, 596.991085066241, 597.3608239184075, 12053.2165409249, 12141.0, 12171.93914030433, 12176.57381991635, 12220.877791222063, 10932.56269749209, 11008.119350451945, 11051.557937682563, 11084.501197446134, 11418.200725949187, 9375.671851485233, 9451.102145296185, 9489.240860731194, 9533.666321678777, 9762.414255144644, 3528.1356067763304, 3591.281743651254, 3596.4245720684567, 3602.513660655804, 3671.9265614687824, 44979.0, 44991.32513012308, 45048.3242751359, 45179.0, 45282.773586132185, 8571.914280857112, 8604.741857744277, 8618.870716939251, 8779.429337093068, 8836.602352894006, 16070.196490175444, 16143.434979775651, 16173.676526469404, 16189.271482783302, 16194.271257793427, 7536.171021187665, 7540.773776786705, 7782.416318776114, 7857.842843143105, 7894.171112033268, 4234.915301693949, 4252.914941701149, 4347.804348804311, 4364.4980827204645, 4411.448568928884, 3093.6751641077362, 3148.7323577495713, 3155.9684403156134, 3163.6994485523837, 3176.5076413155534, 549.9780008799684, 562.1511517608359, 568.9658620482784, 570.965742055478, 574.0757380617202, 512.5259135299833, 522.5088416888113, 535.165142377884, 584.9590528663038, 657.9342065793383, 8092.190780921861, 8294.626741796634, 8412.15878412166, 8450.619722112397, 8804.955975220082, 656.2420404432887, 657.4904449052023, 659.7229163751236, 679.7349033876792, 692.0311563810706, 3801.258754542838, 3858.8456461741775, 4079.7756123413496, 4156.542780294165, 4188.832446702158, 53553.0, 53982.0, 54149.0, 54481.0, 54594.45405545894, 44563.777181114536, 45124.77437612791, 45299.77350113228, 47503.5249647506, 48534.0, 41974.74075777731, 42072.57927420748, 42275.94310142333, 43988.0, 44055.33916991248, 7565.394768418623, 7702.922970770444, 8599.914000859912, 8924.821503569763, 9215.124563166488, 32828.0, 33272.33455330928, 33361.33277334488, 33866.66133338635, 33981.66018339884, 42531.3620295702, 43232.78383608062, 44015.0, 45550.54449455596, 45680.54319456763, 9721.319507634398, 9785.657501987396, 11135.610253641084, 11230.83153752678, 11626.418679066182, 11055.391953442639, 11063.280886742335, 11139.554417823196, 11752.471138798604, 11923.10576706733, 10498.370097794157, 10758.784824303626, 10981.725456863642, 11309.817771858123, 11915.761684766083, 11069.83395249088, 11315.660530184108, 11478.081753459535, 11790.41047947582, 12063.034957203578, 11121.83317250258, 11155.16336274799, 11388.088952883914, 11554.075673946232, 11624.418779061183, 8367.213897915615, 8540.40217184791, 8648.43785153963, 8651.913480865363, 8965.282777377664, 7982.92017079845, 8095.797605059921, 8250.711225107092, 8471.152884711479, 8593.613287402208], "unit": "score", "name": "yui.html", "value": 6012.14198365431}], "name": "dromaeo_css", "value": 6716.410212644354}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 111.0, 105.0, 109.0, 111.0, 110.0, 100.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 148.0, 173.0, 127.0, 150.0, 156.0, 125.0, 173.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 147.6}, {"lowerIsBetter": true, "replicates": [165.0, 161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 161.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 97.0, 100.0, 71.0, 72.0, 73.0, 120.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 144.0, 104.0, 96.0, 96.0, 153.0, 96.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 111.8}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 108.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [67.0, 57.0, 56.0, 55.0, 56.0, 57.0, 56.0, 65.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 83.0, 82.0, 83.0, 83.0, 82.0, 83.0, 88.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [116.0, 112.0, 114.0, 124.0, 112.0, 113.0, 123.0, 115.0, 117.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [141.0, 134.0, 142.0, 139.0, 152.0, 138.0, 140.0, 139.0, 144.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 65.0, 65.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1499.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.6056314280897], "unit": "score", "name": "Richards", "value": 209.3761619999999}, {"lowerIsBetter": false, "replicates": [196.27085377821393], "unit": "score", "name": "DeltaBlue", "value": 336.87120999999996}, {"lowerIsBetter": false, "replicates": [284.57598178713715], "unit": "score", "name": "Encrypt", "value": 935.3600340000003}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [809.7165991902834], "unit": "score", "name": "Earley", "value": 823.0818049999997}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [41795.91836734694], "unit": "score", "name": "RegExp", "value": 21.796027832031257}, {"lowerIsBetter": false, "replicates": [558.282208588957], "unit": "score", "name": "Splay", "value": 145.96739560439565}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 18873.500686777155}]} 06:21:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18873.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1499.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6716.41"}}} 06:21:28 INFO - Return code: 0 06:21:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:21:28 INFO - # TBPL SUCCESS # 06:21:28 INFO - Running post-action listener: _resource_record_post_action 06:21:28 INFO - Running post-run listener: _resource_record_post_run 06:21:29 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 2916352; Write bytes: 303472640; Read time: 824; Write time: 199296 06:21:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1466368; Read time: 0; Write time: 92 06:21:29 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 2916352; Write bytes: 300261376; Read time: 824; Write time: 199140 06:21:29 INFO - Running post-run listener: _upload_blobber_files 06:21:29 INFO - Blob upload gear active. 06:21:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:21:29 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 06:21:29 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'] 06:21:29 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 06:21:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:30 INFO - (blobuploader) - INFO - Done attempting. 06:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:21:31 INFO - (blobuploader) - INFO - Done attempting. 06:21:31 INFO - (blobuploader) - INFO - Iteration through files over. 06:21:31 INFO - Return code: 0 06:21:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:21:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:21:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ccd136a5c74f8202ca0c7215b46c85ac0a290810af38c83848c4502c9b905700d0b26dc33e638aca6f5060f5826930f0c1878c52dd55979ef290651a118330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af756489e2eb08b0b4061e34cd04e7769d3bb37284d7b86ac550b96d6bd636c7f55b5c064329beca97827636b1c4112833bda5c7e38245081db77c239991a80e"} 06:21:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:21:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:21:31 INFO - Contents: 06:21:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ccd136a5c74f8202ca0c7215b46c85ac0a290810af38c83848c4502c9b905700d0b26dc33e638aca6f5060f5826930f0c1878c52dd55979ef290651a118330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af756489e2eb08b0b4061e34cd04e7769d3bb37284d7b86ac550b96d6bd636c7f55b5c064329beca97827636b1c4112833bda5c7e38245081db77c239991a80e"} 06:21:31 INFO - Running post-run listener: copy_logs_to_upload_dir 06:21:31 INFO - Copying logs to upload dir... 06:21:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 06:21:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.862625 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-01-17 06:21:31.629663) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 06:21:31.632964) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ccd136a5c74f8202ca0c7215b46c85ac0a290810af38c83848c4502c9b905700d0b26dc33e638aca6f5060f5826930f0c1878c52dd55979ef290651a118330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af756489e2eb08b0b4061e34cd04e7769d3bb37284d7b86ac550b96d6bd636c7f55b5c064329beca97827636b1c4112833bda5c7e38245081db77c239991a80e"} build_url:https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/cblt-Wl7TiC4D-X8nxqq6w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ccd136a5c74f8202ca0c7215b46c85ac0a290810af38c83848c4502c9b905700d0b26dc33e638aca6f5060f5826930f0c1878c52dd55979ef290651a118330e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af756489e2eb08b0b4061e34cd04e7769d3bb37284d7b86ac550b96d6bd636c7f55b5c064329beca97827636b1c4112833bda5c7e38245081db77c239991a80e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 06:21:31.661898) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:21:31.662609) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1453030869.281828-639378869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 06:21:31.746127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 06:21:31.746795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 06:21:31.747398) ========= ========= Total master_lag: 0.33 =========