builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1451109384.55 results: success (0) buildid: 20151225193239 builduid: dd81fb5c080b4ecabe1686a46fd6ce36 revision: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.547897) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.548348) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.548627) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.585130) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.585527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.697430) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.697697) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.747794) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.748070) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.748397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:24.748664) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 21:56:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-25 21:56:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.256182 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.024401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.024972) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018505 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.076915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.077253) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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 4a559a618d6798eb9a8fdc559f5a7a00085e2062 --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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 21:56:25,414 truncating revision to first 12 chars 2015-12-25 21:56:25,414 Setting DEBUG logging. 2015-12-25 21:56:25,414 attempt 1/10 2015-12-25 21:56:25,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4a559a618d67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 21:56:25,753 unpacking tar archive at: mozilla-central-4a559a618d67/testing/mozharness/ program finished with exit code 0 elapsedTime=0.617349 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.707789) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.708172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.727343) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.727666) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 21:56:25.728058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-25 21:56:25.728334) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:56:26 INFO - MultiFileLogger online at 20151225 21:56:26 in /builds/slave/test-pgo 21:56:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:56:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:56:26 INFO - {'append_to_log': False, 21:56:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:56:26 INFO - 'blob_upload_branch': 'Firefox', 21:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:56:26 INFO - 'branch': 'Firefox', 21:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:56:26 INFO - 'config_files': ('talos/linux_config.py',), 21:56:26 INFO - 'default_actions': ('clobber', 21:56:26 INFO - 'read-buildbot-config', 21:56:26 INFO - 'download-and-extract', 21:56:26 INFO - 'populate-webroot', 21:56:26 INFO - 'create-virtualenv', 21:56:26 INFO - 'install', 21:56:26 INFO - 'run-tests'), 21:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:56:26 INFO - 'download_minidump_stackwalk': True, 21:56:26 INFO - 'download_symbols': 'ondemand', 21:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:56:26 INFO - 'installer_path': 'installer.exe', 21:56:26 INFO - 'log_level': 'info', 21:56:26 INFO - 'log_name': 'talos', 21:56:26 INFO - 'log_to_console': True, 21:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:56:26 INFO - 'opt_config_files': (), 21:56:26 INFO - 'pip_index': False, 21:56:26 INFO - 'sps_profile': False, 21:56:26 INFO - 'sps_profile_interval': 0, 21:56:26 INFO - 'suite': 'dromaeojs-e10s', 21:56:26 INFO - 'system_bits': '64', 21:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:56:26 INFO - 'title': 'talos-linux64-ix-024', 21:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:56:26 INFO - 'use_talos_json': True, 21:56:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:56:26 INFO - 'work_dir': 'build'} 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running clobber step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: clobber 21:56:26 INFO - rmtree: /builds/slave/test-pgo/build 21:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:56:26 INFO - Running post-action listener: _resource_record_post_action 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running read-buildbot-config step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: read_buildbot_config 21:56:26 INFO - Using buildbot properties: 21:56:26 INFO - { 21:56:26 INFO - "project": "", 21:56:26 INFO - "product": "firefox", 21:56:26 INFO - "script_repo_revision": "production", 21:56:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:56:26 INFO - "repository": "", 21:56:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 21:56:26 INFO - "buildid": "20151225193239", 21:56:26 INFO - "pgo_build": "True", 21:56:26 INFO - "basedir": "/builds/slave/test-pgo", 21:56:26 INFO - "buildnumber": 595, 21:56:26 INFO - "slavename": "talos-linux64-ix-024", 21:56:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:56:26 INFO - "platform": "ubuntu64_hw", 21:56:26 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:56:26 INFO - "branch": "mozilla-central", 21:56:26 INFO - "repo_path": "mozilla-central", 21:56:26 INFO - "revision": "4a559a618d6798eb9a8fdc559f5a7a00085e2062", 21:56:26 INFO - "stage_platform": "linux64-pgo", 21:56:26 INFO - "builduid": "dd81fb5c080b4ecabe1686a46fd6ce36", 21:56:26 INFO - "slavebuilddir": "test" 21:56:26 INFO - } 21:56:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:56:26 INFO - Running post-action listener: _resource_record_post_action 21:56:26 INFO - ##### 21:56:26 INFO - ##### Running download-and-extract step. 21:56:26 INFO - ##### 21:56:26 INFO - Running pre-action listener: _resource_record_pre_action 21:56:26 INFO - Running main action method: download_and_extract 21:56:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:56:26 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')]} 21:56:26 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json 21:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json 21:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:56:38 INFO - Downloaded 1302 bytes. 21:56:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:56:38 INFO - Using the following test package requirements: 21:56:38 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:38 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:56:38 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'jsshell-linux-x86_64.zip'], 21:56:38 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:56:38 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:38 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:56:38 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:56:38 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:56:38 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:56:38 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:56:38 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:56:38 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:38 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:48 INFO - Downloaded 23191449 bytes. 21:56:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:49 INFO - Return code: 0 21:56:49 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 21:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:49 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:51 INFO - Downloaded 23191449 bytes. 21:56:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:56:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:56:52 INFO - Return code: 0 21:56: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')]} 21:56:52 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:56:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:53 INFO - Downloaded 11132270 bytes. 21:56:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:56:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:56:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:56:53 INFO - Return code: 0 21:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:53 INFO - https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/11ZYc9WNTJizY1OSNIjf2g/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 21:56:55 INFO - Downloaded 54924771 bytes. 21:56:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:55 INFO - mkdir: /builds/slave/test-pgo/properties 21:56:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:56:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:56:55 INFO - Contents: 21:56:55 INFO - build_url:https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:56:55 INFO - Running post-action listener: _resource_record_post_action 21:56:55 INFO - Running post-action listener: set_extra_try_arguments 21:56:55 INFO - ##### 21:56:55 INFO - ##### Running populate-webroot step. 21:56:55 INFO - ##### 21:56:55 INFO - Running pre-action listener: _resource_record_pre_action 21:56:55 INFO - Running main action method: populate_webroot 21:56:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:56:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:56:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:56:55 INFO - '--tppagecycles', 21:56:55 INFO - '7'], 21:56:55 INFO - 'tests': ['tsvgm']}}, 21:56:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:56:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:56:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:56:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:56:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'tests': ['damp', 'tps']}, 21:56:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['damp', 'tps']}, 21:56:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:56:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:56:55 INFO - 'other': {'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'other_l64': {'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'other_nol64': {'tests': ['a11yr', 21:56:55 INFO - 'ts_paint', 21:56:55 INFO - 'tpaint', 21:56:55 INFO - 'sessionrestore', 21:56:55 INFO - 'sessionrestore_no_auto_restore']}, 21:56:55 INFO - 'svgr': {'tests': ['tsvgx', 21:56:55 INFO - 'tsvgr_opacity', 21:56:55 INFO - 'tart', 21:56:55 INFO - 'tscrollx', 21:56:55 INFO - 'cart']}, 21:56:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['tsvgx', 21:56:55 INFO - 'tsvgr_opacity', 21:56:55 INFO - 'tart', 21:56:55 INFO - 'tscrollx', 21:56:55 INFO - 'cart']}, 21:56:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'tests': ['tp5o']}, 21:56:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'talos_options': ['--e10s'], 21:56:55 INFO - 'tests': ['tp5o']}, 21:56:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'talos_options': ['--xperf_path', 21:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:55 INFO - 'tests': ['tp5n']}, 21:56:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:56:55 INFO - 'talos_options': ['--e10s', 21:56:55 INFO - '--xperf_path', 21:56:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:56:55 INFO - 'tests': ['tp5n']}}, 21:56:55 INFO - 'talos.zip': {'path': '', 21:56:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:56:55 INFO - Running post-action listener: _resource_record_post_action 21:56:55 INFO - ##### 21:56:55 INFO - ##### Running create-virtualenv step. 21:56:55 INFO - ##### 21:56:55 INFO - Running pre-action listener: _resource_record_pre_action 21:56:55 INFO - Running main action method: create_virtualenv 21:56:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:56:55 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 21:56:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:56:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:56:55 INFO - Using real prefix '/usr' 21:56:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:56:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:57 INFO - Installing pip.................done. 21:56:57 INFO - Return code: 0 21:56:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:56:57 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 21:56:57 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 21:56:57 INFO - Using env: {'DISPLAY': ':0', 21:56:57 INFO - 'HOME': '/home/cltbld', 21:56:57 INFO - 'LANG': 'en_US.UTF-8', 21:56:57 INFO - 'LANGUAGE': 'en_US:en', 21:56:57 INFO - 'LOGNAME': 'cltbld', 21:56:57 INFO - 'MAIL': '/var/mail/cltbld', 21:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:57 INFO - 'MOZ_NO_REMOTE': '1', 21:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:57 INFO - 'NO_EM_RESTART': '1', 21:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:57 INFO - 'SHELL': '/bin/bash', 21:56:57 INFO - 'SHLVL': '1', 21:56:57 INFO - 'TERM': 'linux', 21:56:57 INFO - 'TMOUT': '86400', 21:56:57 INFO - 'USER': 'cltbld', 21:56:57 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:57 INFO - '_': '/tools/buildbot/bin/python'} 21:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:57 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 21:56:57 INFO - Cleaning up... 21:56:57 INFO - Return code: 0 21:56:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:56:57 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:56:57 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 21:56:57 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 21:56:57 INFO - Using env: {'DISPLAY': ':0', 21:56:57 INFO - 'HOME': '/home/cltbld', 21:56:57 INFO - 'LANG': 'en_US.UTF-8', 21:56:57 INFO - 'LANGUAGE': 'en_US:en', 21:56:57 INFO - 'LOGNAME': 'cltbld', 21:56:57 INFO - 'MAIL': '/var/mail/cltbld', 21:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:57 INFO - 'MOZ_NO_REMOTE': '1', 21:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:57 INFO - 'NO_EM_RESTART': '1', 21:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:56:57 INFO - 'SHELL': '/bin/bash', 21:56:57 INFO - 'SHLVL': '1', 21:56:57 INFO - 'TERM': 'linux', 21:56:57 INFO - 'TMOUT': '86400', 21:56:57 INFO - 'USER': 'cltbld', 21:56:57 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:57 INFO - '_': '/tools/buildbot/bin/python'} 21:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:58 INFO - Downloading/unpacking psutil>=0.7.1 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:56:58 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 21:56:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:56:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:56:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:59 INFO - Installing collected packages: psutil 21:56:59 INFO - Running setup.py install for psutil 21:56:59 INFO - building 'psutil._psutil_linux' extension 21:56:59 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 21:57:00 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 21:57:00 INFO - building 'psutil._psutil_posix' extension 21:57:00 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 21:57:00 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 21:57:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:57:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:57:00 INFO - Successfully installed psutil 21:57:00 INFO - Cleaning up... 21:57:00 INFO - Return code: 0 21:57:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:57:00 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')]} 21:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 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')]} 21:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:00 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:00 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 21:57:00 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 21:57:00 INFO - Using env: {'DISPLAY': ':0', 21:57:00 INFO - 'HOME': '/home/cltbld', 21:57:00 INFO - 'LANG': 'en_US.UTF-8', 21:57:00 INFO - 'LANGUAGE': 'en_US:en', 21:57:00 INFO - 'LOGNAME': 'cltbld', 21:57:00 INFO - 'MAIL': '/var/mail/cltbld', 21:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:00 INFO - 'MOZ_NO_REMOTE': '1', 21:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:00 INFO - 'NO_EM_RESTART': '1', 21:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:00 INFO - 'SHELL': '/bin/bash', 21:57:00 INFO - 'SHLVL': '1', 21:57:00 INFO - 'TERM': 'linux', 21:57:00 INFO - 'TMOUT': '86400', 21:57:00 INFO - 'USER': 'cltbld', 21:57:00 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:00 INFO - '_': '/tools/buildbot/bin/python'} 21:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:00 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 21:57:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:57:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:57:02 INFO - Installing collected packages: mozsystemmonitor 21:57:02 INFO - Running setup.py install for mozsystemmonitor 21:57:02 INFO - Successfully installed mozsystemmonitor 21:57:02 INFO - Cleaning up... 21:57:02 INFO - Return code: 0 21:57:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:02 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:02 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 21:57:02 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 21:57:02 INFO - Using env: {'DISPLAY': ':0', 21:57:02 INFO - 'HOME': '/home/cltbld', 21:57:02 INFO - 'LANG': 'en_US.UTF-8', 21:57:02 INFO - 'LANGUAGE': 'en_US:en', 21:57:02 INFO - 'LOGNAME': 'cltbld', 21:57:02 INFO - 'MAIL': '/var/mail/cltbld', 21:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:02 INFO - 'MOZ_NO_REMOTE': '1', 21:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:02 INFO - 'NO_EM_RESTART': '1', 21:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:02 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:02 INFO - 'SHELL': '/bin/bash', 21:57:02 INFO - 'SHLVL': '1', 21:57:02 INFO - 'TERM': 'linux', 21:57:02 INFO - 'TMOUT': '86400', 21:57:02 INFO - 'USER': 'cltbld', 21:57:02 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:02 INFO - '_': '/tools/buildbot/bin/python'} 21:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:02 INFO - Downloading/unpacking blobuploader==1.2.4 21:57:02 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 21:57:02 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 21:57:02 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 21:57:02 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 21:57:02 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 21:57:02 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 21:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 21:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:57:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:57:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 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 21:57:04 INFO - Downloading docopt-0.6.1.tar.gz 21:57:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:57:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:57:05 INFO - Running setup.py install for blobuploader 21:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:57:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:57:05 INFO - Running setup.py install for requests 21:57:05 INFO - Running setup.py install for docopt 21:57:05 INFO - Successfully installed blobuploader requests docopt 21:57:05 INFO - Cleaning up... 21:57:05 INFO - Return code: 0 21:57:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:05 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:05 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 21:57:05 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 21:57:05 INFO - Using env: {'DISPLAY': ':0', 21:57:05 INFO - 'HOME': '/home/cltbld', 21:57:05 INFO - 'LANG': 'en_US.UTF-8', 21:57:05 INFO - 'LANGUAGE': 'en_US:en', 21:57:05 INFO - 'LOGNAME': 'cltbld', 21:57:05 INFO - 'MAIL': '/var/mail/cltbld', 21:57:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:05 INFO - 'MOZ_NO_REMOTE': '1', 21:57:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:05 INFO - 'NO_EM_RESTART': '1', 21:57:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:05 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:05 INFO - 'SHELL': '/bin/bash', 21:57:05 INFO - 'SHLVL': '1', 21:57:05 INFO - 'TERM': 'linux', 21:57:05 INFO - 'TMOUT': '86400', 21:57:05 INFO - 'USER': 'cltbld', 21:57:05 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:05 INFO - '_': '/tools/buildbot/bin/python'} 21:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:05 INFO - Running setup.py (path:/tmp/pip-VOKHFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:05 INFO - Running setup.py (path:/tmp/pip-gyOkp_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:06 INFO - Running setup.py (path:/tmp/pip-TmT1hu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:06 INFO - Running setup.py (path:/tmp/pip-t7BHF4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:06 INFO - Running setup.py (path:/tmp/pip-IWzUpo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:06 INFO - Running setup.py (path:/tmp/pip-tb9caX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:06 INFO - Running setup.py (path:/tmp/pip-KiIMrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:06 INFO - Running setup.py (path:/tmp/pip-B9hSuz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:06 INFO - Running setup.py (path:/tmp/pip-3Pfxdu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:06 INFO - Running setup.py (path:/tmp/pip-VJ9v6C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:06 INFO - Running setup.py (path:/tmp/pip-6Q7Ew8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:06 INFO - Running setup.py (path:/tmp/pip-X4eZD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:06 INFO - Running setup.py (path:/tmp/pip-clyxf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:06 INFO - Running setup.py (path:/tmp/pip-MfK3vW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:06 INFO - Running setup.py (path:/tmp/pip-9lPL0r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:06 INFO - Running setup.py (path:/tmp/pip-yZEk4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:07 INFO - Running setup.py (path:/tmp/pip-7r0OEy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:57:07 INFO - Running setup.py install for manifestparser 21:57:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Running setup.py install for mozcrash 21:57:07 INFO - Running setup.py install for mozdebug 21:57:07 INFO - Running setup.py install for mozdevice 21:57:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Running setup.py install for mozfile 21:57:07 INFO - Running setup.py install for mozhttpd 21:57:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Running setup.py install for mozinfo 21:57:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Running setup.py install for mozInstall 21:57:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:57:07 INFO - Running setup.py install for mozleak 21:57:07 INFO - Running setup.py install for mozlog 21:57:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Running setup.py install for moznetwork 21:57:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Running setup.py install for mozprocess 21:57:08 INFO - Running setup.py install for mozprofile 21:57:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Running setup.py install for mozrunner 21:57:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Running setup.py install for mozscreenshot 21:57:08 INFO - Running setup.py install for moztest 21:57:08 INFO - Running setup.py install for mozversion 21:57:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:57:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:57:08 INFO - Cleaning up... 21:57:08 INFO - Return code: 0 21:57:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:08 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')]} 21:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:08 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')]} 21:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:08 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:08 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 21:57:08 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 21:57:08 INFO - Using env: {'DISPLAY': ':0', 21:57:08 INFO - 'HOME': '/home/cltbld', 21:57:08 INFO - 'LANG': 'en_US.UTF-8', 21:57:08 INFO - 'LANGUAGE': 'en_US:en', 21:57:08 INFO - 'LOGNAME': 'cltbld', 21:57:08 INFO - 'MAIL': '/var/mail/cltbld', 21:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:08 INFO - 'MOZ_NO_REMOTE': '1', 21:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:08 INFO - 'NO_EM_RESTART': '1', 21:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:08 INFO - 'SHELL': '/bin/bash', 21:57:08 INFO - 'SHLVL': '1', 21:57:08 INFO - 'TERM': 'linux', 21:57:08 INFO - 'TMOUT': '86400', 21:57:08 INFO - 'USER': 'cltbld', 21:57:08 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:08 INFO - '_': '/tools/buildbot/bin/python'} 21:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:09 INFO - Running setup.py (path:/tmp/pip-A1JmjA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:09 INFO - Running setup.py (path:/tmp/pip-Nc6eB8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:09 INFO - Running setup.py (path:/tmp/pip-VOgMJJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:09 INFO - Running setup.py (path:/tmp/pip-RmE14V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:09 INFO - Running setup.py (path:/tmp/pip-SMFKZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:09 INFO - Running setup.py (path:/tmp/pip-p36YkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:09 INFO - Running setup.py (path:/tmp/pip-NgBaUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:09 INFO - Running setup.py (path:/tmp/pip-OAjira-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:09 INFO - Running setup.py (path:/tmp/pip-RnmJxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:09 INFO - Running setup.py (path:/tmp/pip-nrp3qR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:09 INFO - Running setup.py (path:/tmp/pip-hSp2JC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:09 INFO - Running setup.py (path:/tmp/pip-9Dt08q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:57:09 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)) 21:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:09 INFO - Running setup.py (path:/tmp/pip-vWMtFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:57:10 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)) 21:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:10 INFO - Running setup.py (path:/tmp/pip-WkjkRw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:57:10 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)) 21:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:10 INFO - Running setup.py (path:/tmp/pip-zdWI3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:57:10 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)) 21:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:10 INFO - Running setup.py (path:/tmp/pip-0p7foR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:57:10 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)) 21:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:10 INFO - Running setup.py (path:/tmp/pip-iVmYgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:57:10 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)) 21:57:10 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)) 21:57:10 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)) 21:57:10 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)) 21:57:10 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:10 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:57:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:12 INFO - Downloading blessings-1.5.1.tar.gz 21:57:12 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 21:57:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:57:12 INFO - Installing collected packages: blessings 21:57:12 INFO - Running setup.py install for blessings 21:57:12 INFO - Successfully installed blessings 21:57:12 INFO - Cleaning up... 21:57:12 INFO - Return code: 0 21:57:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:57:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:12 INFO - Reading from file tmpfile_stdout 21:57:12 INFO - Current package versions: 21:57:12 INFO - argparse == 1.2.1 21:57:12 INFO - blessings == 1.5.1 21:57:12 INFO - blobuploader == 1.2.4 21:57:12 INFO - docopt == 0.6.1 21:57:12 INFO - manifestparser == 1.1 21:57:12 INFO - mozInstall == 1.12 21:57:12 INFO - mozcrash == 0.16 21:57:12 INFO - mozdebug == 0.1 21:57:12 INFO - mozdevice == 0.47 21:57:12 INFO - mozfile == 1.2 21:57:12 INFO - mozhttpd == 0.7 21:57:12 INFO - mozinfo == 0.9 21:57:12 INFO - mozleak == 0.1 21:57:12 INFO - mozlog == 3.1 21:57:12 INFO - moznetwork == 0.27 21:57:12 INFO - mozprocess == 0.22 21:57:12 INFO - mozprofile == 0.28 21:57:12 INFO - mozrunner == 6.11 21:57:12 INFO - mozscreenshot == 0.1 21:57:12 INFO - mozsystemmonitor == 0.0 21:57:12 INFO - moztest == 0.7 21:57:12 INFO - mozversion == 1.4 21:57:12 INFO - psutil == 3.1.1 21:57:12 INFO - requests == 1.2.3 21:57:12 INFO - wsgiref == 0.1.2 21:57:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:12 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:12 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 21:57:12 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 21:57:12 INFO - Using env: {'DISPLAY': ':0', 21:57:12 INFO - 'HOME': '/home/cltbld', 21:57:12 INFO - 'LANG': 'en_US.UTF-8', 21:57:12 INFO - 'LANGUAGE': 'en_US:en', 21:57:12 INFO - 'LOGNAME': 'cltbld', 21:57:12 INFO - 'MAIL': '/var/mail/cltbld', 21:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:12 INFO - 'MOZ_NO_REMOTE': '1', 21:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:12 INFO - 'NO_EM_RESTART': '1', 21:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:12 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:12 INFO - 'SHELL': '/bin/bash', 21:57:12 INFO - 'SHLVL': '1', 21:57:12 INFO - 'TERM': 'linux', 21:57:12 INFO - 'TMOUT': '86400', 21:57:12 INFO - 'USER': 'cltbld', 21:57:12 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:12 INFO - '_': '/tools/buildbot/bin/python'} 21:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 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)) 21:57:12 INFO - Cleaning up... 21:57:12 INFO - Return code: 0 21:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:12 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:12 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 21:57:12 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 21:57:12 INFO - Using env: {'DISPLAY': ':0', 21:57:12 INFO - 'HOME': '/home/cltbld', 21:57:12 INFO - 'LANG': 'en_US.UTF-8', 21:57:12 INFO - 'LANGUAGE': 'en_US:en', 21:57:12 INFO - 'LOGNAME': 'cltbld', 21:57:12 INFO - 'MAIL': '/var/mail/cltbld', 21:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:12 INFO - 'MOZ_NO_REMOTE': '1', 21:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:12 INFO - 'NO_EM_RESTART': '1', 21:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:12 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:12 INFO - 'SHELL': '/bin/bash', 21:57:12 INFO - 'SHLVL': '1', 21:57:12 INFO - 'TERM': 'linux', 21:57:12 INFO - 'TMOUT': '86400', 21:57:12 INFO - 'USER': 'cltbld', 21:57:12 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:12 INFO - '_': '/tools/buildbot/bin/python'} 21:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:12 INFO - Downloading/unpacking jsonschema 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:57:14 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 21:57:14 INFO - Downloading/unpacking functools32 (from jsonschema) 21:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:57:14 INFO - Downloading functools32-3.2.3-2.tar.gz 21:57:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:57:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:57:14 INFO - warning: no files found matching '*.txt' 21:57:14 INFO - no previously-included directories found matching 'build' 21:57:14 INFO - no previously-included directories found matching 'dist' 21:57:14 INFO - no previously-included directories found matching '.git*' 21:57:14 INFO - Installing collected packages: jsonschema, functools32 21:57:14 INFO - Running setup.py install for functools32 21:57:14 INFO - warning: no files found matching '*.txt' 21:57:14 INFO - no previously-included directories found matching 'build' 21:57:14 INFO - no previously-included directories found matching 'dist' 21:57:14 INFO - no previously-included directories found matching '.git*' 21:57:14 INFO - Successfully installed jsonschema functools32 21:57:14 INFO - Cleaning up... 21:57:15 INFO - Return code: 0 21:57:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:57:15 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 0x7f7877f4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e69630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', '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 21:57:15 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 21:57:15 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 21:57:15 INFO - Using env: {'DISPLAY': ':0', 21:57:15 INFO - 'HOME': '/home/cltbld', 21:57:15 INFO - 'LANG': 'en_US.UTF-8', 21:57:15 INFO - 'LANGUAGE': 'en_US:en', 21:57:15 INFO - 'LOGNAME': 'cltbld', 21:57:15 INFO - 'MAIL': '/var/mail/cltbld', 21:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:15 INFO - 'MOZ_NO_REMOTE': '1', 21:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:15 INFO - 'NO_EM_RESTART': '1', 21:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:15 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:15 INFO - 'SHELL': '/bin/bash', 21:57:15 INFO - 'SHLVL': '1', 21:57:15 INFO - 'TERM': 'linux', 21:57:15 INFO - 'TMOUT': '86400', 21:57:15 INFO - 'USER': 'cltbld', 21:57:15 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:15 INFO - '_': '/tools/buildbot/bin/python'} 21:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:57:15 INFO - Downloading/unpacking flake8 21:57:15 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 21:57:15 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 21:57:15 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 21:57:15 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 21:57:15 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 21:57:15 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 21:57:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:57:16 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 21:57:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:57:16 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 21:57:16 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 21:57:16 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 21:57:16 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 21:57:16 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 21:57:16 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 21:57:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:57:17 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 21:57:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 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 21:57:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:57:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:57:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:17 INFO - no previously-included directories found matching 'docs/_build' 21:57:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:57:17 INFO - Running setup.py install for pep8 21:57:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:57:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:57:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:57:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:57:17 INFO - no previously-included directories found matching 'docs/_build' 21:57:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:57:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:57:17 INFO - Cleaning up... 21:57:17 INFO - Return code: 0 21:57:17 INFO - Running post-action listener: _resource_record_post_action 21:57:17 INFO - Running post-action listener: _start_resource_monitoring 21:57:17 INFO - Starting resource monitoring. 21:57:17 INFO - ##### 21:57:17 INFO - ##### Running install step. 21:57:17 INFO - ##### 21:57:17 INFO - Running pre-action listener: _resource_record_pre_action 21:57:17 INFO - Running main action method: install 21:57:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:57:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:57:18 INFO - Reading from file tmpfile_stdout 21:57:18 INFO - Detecting whether we're running mozinstall >=1.0... 21:57:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:57:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:57:18 INFO - Reading from file tmpfile_stdout 21:57:18 INFO - Output received: 21:57:18 INFO - Usage: mozinstall [options] installer 21:57:18 INFO - Options: 21:57:18 INFO - -h, --help show this help message and exit 21:57:18 INFO - -d DEST, --destination=DEST 21:57:18 INFO - Directory to install application into. [default: 21:57:18 INFO - "/builds/slave/test-pgo"] 21:57:18 INFO - --app=APP Application being installed. [default: firefox] 21:57:18 INFO - mkdir: /builds/slave/test-pgo/build/application 21:57:18 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'] 21:57:18 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 21:57:34 INFO - Reading from file tmpfile_stdout 21:57:34 INFO - Output received: 21:57:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:57:34 INFO - Running post-action listener: _resource_record_post_action 21:57:34 INFO - ##### 21:57:34 INFO - ##### Running run-tests step. 21:57:34 INFO - ##### 21:57:34 INFO - Running pre-action listener: _resource_record_pre_action 21:57:34 INFO - Running main action method: run_tests 21:57:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:57:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:57:34 INFO - Python 2.7.3 21:57:34 INFO - Return code: 0 21:57:34 INFO - grabbing minidump binary from tooltool 21:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:57:34 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 0x1efa840>, '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 0x1e676b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e67b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:57:34 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 21:57:34 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 21:57:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:57:34 INFO - Return code: 0 21:57:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:57:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:57:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:57:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:57:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:57:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:57:35 INFO - Return code: 0 21:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 21:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:57:35 INFO - Using env: {'DISPLAY': ':0', 21:57:35 INFO - 'HOME': '/home/cltbld', 21:57:35 INFO - 'LANG': 'en_US.UTF-8', 21:57:35 INFO - 'LANGUAGE': 'en_US:en', 21:57:35 INFO - 'LOGNAME': 'cltbld', 21:57:35 INFO - 'MAIL': '/var/mail/cltbld', 21:57:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:57:35 INFO - 'MOZ_NO_REMOTE': '1', 21:57:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:57:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:57:35 INFO - 'NO_EM_RESTART': '1', 21:57:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:57:35 INFO - 'PWD': '/builds/slave/test-pgo', 21:57:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:57:35 INFO - 'SHELL': '/bin/bash', 21:57:35 INFO - 'SHLVL': '1', 21:57:35 INFO - 'TERM': 'linux', 21:57:35 INFO - 'TMOUT': '86400', 21:57:35 INFO - 'USER': 'cltbld', 21:57:35 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455', 21:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:57:35 INFO - '_': '/tools/buildbot/bin/python'} 21:57:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:57:35 INFO - mozversion application_buildid: 20151225193239 21:57:35 INFO - mozversion application_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 21:57:35 INFO - mozversion application_display_name: Nightly 21:57:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:57:35 INFO - mozversion application_name: Firefox 21:57:35 INFO - mozversion application_remotingname: firefox 21:57:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:57:35 INFO - mozversion application_vendor: Mozilla 21:57:35 INFO - mozversion application_version: 46.0a1 21:57:35 INFO - mozversion platform_buildid: 20151225193239 21:57:35 INFO - mozversion platform_changeset: 4a559a618d6798eb9a8fdc559f5a7a00085e2062 21:57:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:57:35 INFO - mozversion platform_version: 46.0a1 21:57:35 INFO - using testdate: 1451109455 21:57:35 INFO - actual date: 1451109455 21:57:35 INFO - starting webserver on 'localhost:41746' 21:57:35 INFO - SUITE-START | Running 3 tests 21:57:35 INFO - TEST-START | dromaeo_css 21:57:35 INFO - operating with platform_type : linux_ 21:57:35 INFO - Initialising browser for dromaeo_css test... 21:57:35 INFO - TEST-INFO | started process 6246 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSemRJE/profile http://localhost:41746/getInfo.html) 21:57:39 INFO - PROCESS | 6246 | __metrics Screen width/height:1600/1200 21:57:39 INFO - PROCESS | 6246 | colorDepth:24 21:57:39 INFO - PROCESS | 6246 | Browser inner width/height: 1024/697 21:57:39 INFO - PROCESS | 6246 | __metrics 21:57:39 INFO - PROCESS | 6246 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:57:40 INFO - TEST-INFO | 6246: exit 0 21:57:40 INFO - Browser initialized. 21:57:40 INFO - Running cycle 1/1 for dromaeo_css test... 21:57:40 INFO - TEST-INFO | started process 6379 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSemRJE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:57:52 INFO - PROCESS | 6379 | RSS: Main: 149508096 21:57:52 INFO - PROCESS | 6379 | 21:58:42 INFO - PROCESS | 6379 | 1451109522184 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:00:50 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41746/tests/dromaeo/cssquery-ext.html) 22:00:51 INFO - PROCESS | 6379 | RSS: Main: 158490624 22:00:51 INFO - PROCESS | 6379 | 22:03:53 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-ext.html (next: http://localhost:41746/tests/dromaeo/cssquery-jquery.html) 22:03:54 INFO - PROCESS | 6379 | RSS: Main: 153387008 22:03:54 INFO - PROCESS | 6379 | 22:06:56 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41746/tests/dromaeo/cssquery-mootools.html) 22:06:56 INFO - PROCESS | 6379 | RSS: Main: 153014272 22:06:56 INFO - PROCESS | 6379 | 22:09:58 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41746/tests/dromaeo/cssquery-prototype.html) 22:09:58 INFO - PROCESS | 6379 | RSS: Main: 152510464 22:09:58 INFO - PROCESS | 6379 | 22:13:01 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41746/tests/dromaeo/cssquery-yui.html) 22:13:01 INFO - PROCESS | 6379 | RSS: Main: 153092096 22:13:01 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | Cycle 1(1): loaded http://localhost:41746/tests/dromaeo/cssquery-yui.html (next: http://localhost:41746/tests/dromaeo/cssquery-dojo.html) 22:16:04 INFO - PROCESS | 6379 | RSS: Main: 155226112 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | __start_tp_report 22:16:04 INFO - PROCESS | 6379 | _x_x_mozilla_page_load 22:16:04 INFO - PROCESS | 6379 | _x_x_mozilla_page_load_details 22:16:04 INFO - PROCESS | 6379 | |i|pagename|runs| 22:16:04 INFO - PROCESS | 6379 | |0;dojo.html;3177;3188.9521657175146;3222.5810644616195;3230.757693173012;3249.0252924122756;5133.153029750087;5193.480651934809;5193.922091168631;5196.792128314873;5212.2963399941;5190.636655434121;5219.086659834523;5236.423993360727;5245.606579506533;5283.181106928432;4426.490953540336;4749.620030397568;4892;4905.533974272438;4925.926111108336;4752.477227504972;4846.151923413407;4866.440359358684;4889.608831293488;4917.631177661672;4710.105080034799;4776.522347765213;4782.856514304576;4783.617310615143;4810.879728006793;4724.480307166244;4730.905381892378;4763.666543341968;4765.428148622153;4768.904621907577;4752.952470475286;4753.9762301188275;4774.4509381420885;4776.546228108324;4785.21044027735;4958.900821983576;5068.3917929848285;5079.619028572835;5081.872953176163;5087.720175390352;5661.518770904437;5718.085106382959;5718.628289161233;5742.224799652077;5778.711064446803;5647.37878833328;5662.6036177467595;5665.291838520185;5683.090705487143;5701.77192912283;5286.550643195333;5311.946880531223;5334.253204551366;5338.8665283367445;5374.032674118696;5757.251557297524;5765.106408506688;5771.220885180531;5782.6819524925695;5783.248177736868;5471.699056551928;5496.367917689437;5533.335999680065;5539.224508568804;5573.164025396142;5442.2380866678695;5557.110862262019;5573.944260557424;5706.80026199081;5803.216565763568;5597.74810133545;5603.5237004854225;5603.691796951125;5606.018946684314;5616.269884914935;5576.581756368289;5596.3284405871555;5596.748146333425;5598.356189038232;5601.5238704709745;4308.978455107705;4359.716618419792;4378.496472905593;4398.890027749332;4457.621102206284;3869.787161706077;3886.630770076838;3907.5115610548683;3929.115948911472;3930.6855451563806;5189.455107213764;5249.553787927993;5261.631685782035;5265.552428043583;5286.07493688603;5493.560515158778;5580.274564306615;5602.85992850182;5631.493165615114;5647.068233741469;5309.36287645485;5324.334458192726;5355;5360.088784906575;5363.222332761806;4908.9754551227015;4945.480724523945;4946.653734238641;4946.826861059845;4977.626677999165;5752.626079304831;5837.182794408786;5851.239338885917;5895.498882594941;5959.404059594092;5616.971915140398;5645.435456454322;5661.886762264814;5677.545796336366;5737.368889422244;5810.244668193108;5850.5904586678525;5850.859082478876;5857.26784151981;5864.560157988253;5476.3702174250475;5498.80754173602;5565.526930210977;5586.860328491658;5590.440955904377;5623;5654.067078932095;5658.094704847204;5673.971630141823;5682.062459694104;5506.476884695948;5511.5315198207;5523.226748255328;5525.336959564878;5533.5849811263515;5407.78368865241;5489.3687225969525;5532.0595498766115;5592.832215033555;5664.886702265849;5444.047291724011;5446.700431476307;5450.1007333789485;5466.1527463243265;5475.479829416199;5545.584081194007;5565.944340556543;5570.359408668055;5580.972095139661;5626.634268772516;5248.160294352885;5304.283921670525;5368.651037682538;5469.863253418696;5571.693556854412 22:16:04 INFO - PROCESS | 6379 | |1;ext.html;550.7604192176403;589.6579983609504;598.9311229208641;602.9629038054545;606.4875180472502;35820.820895895515;35954;36079.819600902025;36154.81922590383;36284.63715362846;38922;39399;39437.21125577487;39628.405573916345;39751.20497590054;8420.326373890104;8652.351073669468;8667.17661822126;8680.435771674822;8706.869396959051;8459.577021148949;8518.446300990447;8536.359773017017;8644.049154592989;8683.175098365646;8623.13768623139;8684.13158684133;8694.174053464942;8717.433366831136;8728.956355218215;8629.95685021574;8719.60761765722;8727.650893964234;8730.214280714703;8738.388312818042;8587.355948303839;8600.827983440297;8684.305255579538;8695.173958473935;8708.30333573319;39308.41037384442;39611.20777584432;39880;39927.60072399297;39971.600283997366;3329.3674201901563;3361.5125806757883;3531.876384326536;3709.1283548366114;3914.080191155076;29053.12840614785;29301.56047659287;29421;29615.851920740475;29737.405251895056;3708.629137086297;3861.8841434757;3924.9803750981346;4035.435039094529;4084.407760874686;190451;190789;190859;191163;191409.9999999986;53428;54396.728016359666;57808.4219157803;58077.709611451675;60137.39862601318;53920.73039634777;54001.45998540043;54113;54163.72918135463;54172.18741718798;15795.131267780382;15796.131212783177;15826.92086539583;15852.92073539648;15957.601059973362;11073.778524429466;11112.777744445228;11131.777364452666;11138.108951283877;11169.72075698114;19156.67265229788;19609.31367402134;20364.69452958207;20374.388768336972;20408.38774836757;7338.522996005243;7339.88990165148;7369.189389167187;7418.629068546659;7568.470207085451;941.2470023980788;953.9347313067132;970.1608108985818;995.4674249276602;1010.1363334349172;27848.582271265946;28032;28130.859345703142;28260;28303.15090547287;1022.1924679503257;1051.7686109056149;1073.8281874899978;1091.901728844408;1114.2311804854623;14717.264136793117;14728.55814325572;14730.779038314435;14911.70176596462;15087.547373578811;323999;326381;326822;327476;328483;51300.48699513032;51616.48383516117;51624.48375516272;51697.48302516927;51751.48248517542;1338.4779935825036;1345.8721421464945;1347.1243691600341;1352.377906163176;1354.8780609744972;26253.474930501667;27445.588316175672;27616.861915691097;27832.582511261942;28020.57969130424;46238;46418.30372544347;46540;46795.532044679116;47049;299409;300429;300612;301000;302688;31802.840985794923;31970.52044219385;32191.19522011875;32390.83804580962;32545.34909301848;37750.62249377471;37827.05432364213;38500.42249366318;38759.224815504094;39232.607673922896;34568.308633827684;34858.825705871306;34958.65041349554;35311.56974602536;35691.28617427585;35041.474377883846;35437.82281088578;35498.82250588731;35885.64114358823;35917.461238081974;33856.322873542886;34462.655373445945;34966.47550286697;34991.82504087463;35191.47212791759;30794;31539;32076.19809504781;32246.83876580602;32335.514967275038;23181.652275215547;23403;23423.94592243319;24253.636195457435;24671.62992555149 22:16:04 INFO - PROCESS | 6379 | |2;jquery.html;358.97870558261735;360.79254428703496;361.167508892004;362.1525630025739;364.46423757077093;14108.15351078936;14387.928060359709;16629.667406651875;16919.577010574725;17565.912170439147;14682.192479413628;14766.409343626268;14817.703645927075;14818;14824.407023719064;5317.813876514323;5371.221172929922;5472.370677372113;5476.151196564539;5482.616216864821;5431.592630552705;5468.0977638689565;5477.808276710316;5482.17767334899;5482.39693633702;5319.973400132994;5450.073487507114;5534.944650553503;5542.972285138569;5545.112781954888;5486.451354864522;5500.642458240201;5511.614187006911;5514;5532.889342213133;4857.247126695368;4924.138275801756;4936.185529387647;4947;4950.455449900508;19878.50303742418;19911.80088199114;20066;20328.186872525228;20579.794202057936;2165.4153378587694;2199.212222487466;2306.4579823741406;2399.3881560202212;2417.9395515112087;9304.255659547287;9425.811483770287;9447.716568502956;9570.617175312978;9664.71005869825;1792.1129041124727;1803.0624075480807;1835.623697142096;1913.3590247267182;1979.4556496963307;58777;60539.394606053815;61197;61438.385616143714;61856.69071654613;10284.331518451278;10297.639582614573;10373.533191006423;10405.06354428105;10461.84307235392;11924.821127683092;12437.813432798515;12485.812712809315;13573.321333933263;13611.455541778416;7073.186583542855;7264.019357386791;7360.411167106618;7383.114026316876;7405.851882962311;6941.479389045841;6950.374466297956;6955.478339124586;6975.686094125675;7009.859802803915;4307.483102027777;4337.479502459725;4338.067315527177;4343.326784348431;4344.978275108604;1821.653885761701;1847.6120014797043;1847.8429333506801;1889.0649128681391;1902.7145928110895;845.3828705045352;893.8078313162702;992.4739887859446;1060.2525219720078;1089.145021158387;16820.915895420443;17158.914205429144;17259.91370043167;17284;17787.555311117325;921.5806807902388;986.161762501882;986.6842610364758;998.2662742883974;1017.9491025448698;9683;9883.654072107442;9908.504574771232;9934.056264654846;9961.950190249147;137216;137748;469960;494288;497933;78704;79292.6035369831;82633;84416.61548601557;86321.87240679402;1124.791913496006;1160.878107798686;1176.088531388181;1176.3177357132843;1185.4724647531766;15142.470013549473;15230.238488075773;15261.694766104838;15264;15299.46451874179;30615.2346191347;32551.51172732458;33510.66489335173;33742.831285843415;35783.10542236465;41035.58964410318;43336.566634333256;43430.34854477122;44216.77891610521;46963.530364695915;9439;9727;9897.406155630686;9912.504374781376;10001.399916005063;11605.535778568763;11729.120315976506;11742.647720568397;11810.055195584504;12127.393630318626;14339.283035848375;14404.927975360057;14464.27678616086;14482.710345793235;14931.253437327872;14155.433782648579;14412.855871441152;14615.780763288773;14741.705165896408;15213;15217.847821522086;15378.692426151638;15413.152276624893;15749.606259843596;15767.68464630678;9776.80446391054;9866.605335786488;9924.354916930377;9971.551280192263;9972.850407243752;15016.399344026117;15073.854689960348;15170.31733572014;15281.312340944462;15393.537034074494 22:16:04 INFO - PROCESS | 6379 | |3;mootools.html;1421.4953691439537;1458.0668372241764;1623.3425462687608;1756.1219390304848;1794.1029485257363;6439.130717353168;6452.354764523545;7298.854022919545;7431.033965584466;7452.478326517146;7100.57396556207;7189.173245076805;7221.4944953853255;7313.561186328824;7322.1945585985495;2222.7777222277805;2246.6742322363248;2251.684764133023;2255.5263394687136;2260.0507786729613;2229.2754854672216;2243.1924507177405;2317.4669825940045;2318.5015221727326;2320.153144102407;2233.553289342138;2238.630625946725;2265.991633722994;2272.9090836366527;2295.288460577218;2224.254874617005;2227.532218234173;2277.202978957368;2280.8631482111127;2282.018731945271;2245.158065725353;2265.32040387883;2266.2747920665392;2272.1820144747876;2276.442271643458;7324.890126648104;7332.266773322678;7391.854262589307;7418.332350088518;7422.888656670154;4509.819607215707;4609.492955774862;4616.28447590624;4629.328747331618;4632.374629425052;2983.522636378191;2994.0718377302887;3068.248279171617;3095.721385075354;3096.0866544369464;930.7161315798679;946.9952650236705;973.3332667123043;984.807962447323;995.7411073120968;10082;10083.546240419199;10105.090541851196;10110.090091891692;10128.240381971382;4123.0516981093915;4157.272477316518;4191.119864828359;4206.3690446432665;4210.179015092028;8633.91366086331;8677.739667809976;8687.391882568287;8693.217610415093;8710.695125670698;4620.029793743284;4639.37368455261;4663.953360466419;4693.389859318267;4693.78877950493;4134.813933373005;4170.082581831992;4224.366345048206;4236.428082208924;4243.108947121139;3378.1048022274117;3392.8133952632843;3395.2360718838063;3400.7789493683326;3426.3832510147913;1014.4572653630272;1024.5491983527224;1029.1098200057047;1036.8133735927454;1047.3244757131608;1128.351198061118;1167.5154810753443;1169.9473523691454;1204.9457774399998;1257.5661396818266;6540.509461790385;6569.770058048041;6574.243961944342;6623.105880706139;6631;475.8501072162258;476.4758765358148;486.29972839111565;490.364977354327;490.7374554613265;5412.864678383072;5434.538064264581;5447.591430642638;5457.126859702428;5474.124140137559;8657.696980605648;8729.60716767747;8986.19124278818;9014.18872301483;9030.36787424874;8786.384953053224;8895.4662720237;8907.242884354773;8981.730548083437;8989.41568798026;6958.373746362851;7051;7086.078809754699;7091.113610798753;7105.75129870452;6810.28492008332;6837.589744615339;6840.281770414035;6851.45188384918;6857.314268573103;7865.882011769713;8006.83986320282;8020.679172833022;8082.434229603871;8127.2279133482225;7939.642716077675;8177.509349438815;8194.22154895284;8213.671453141807;8295.709650162215;5983;6012.1582978382185;6369;6534.575252608755;6546.967265163644;6984.441244700513;7080.752173674103;7083.220845707071;7100.218975912542;7117.181524124792;6531.934680653133;6575.605463672195;6822.317768223138;6823.590584564942;6869.519133660796;6395.104685343963;6448.806970710246;6453.09656648079;6521;6549.8690026200165;6739.898901516383;6779.15260592426;6782.559133656297;6790.354916282945;6810.9318906810295;6044.093385992136;6110.327863935053;6143.877122457615;6144;6228.750849965951;6133.264008318852;6176.845578860564;6186.319504854552;6193.721282542207;6194.4115309045565 22:16:04 INFO - PROCESS | 6379 | |4;prototype.html;334.06628473416805;336.27364891833645;341.9008487538614;343.3099470065169;343.5379414687246;6259.8122056338325;6278.152449419333;6284.245890493142;6286.559940804145;6379.808605741823;6216.564840461169;6266.561340706153;6267.43593076623;6284.654344011077;6297.496200303976;4750.097481478517;4773.069251495942;4780;4790.7604619769045;4796.208625576775;4787.593054590364;4789.114013907439;4794.352762377087;4794.9280760788615;4795.856124316276;4653.139169253699;4743.928841067387;4746.833860814872;4750.97624511877;4756.9286460703115;4738.620910327183;4741.431028276612;4753.930365667732;4758.690685105492;4773.880652983668;4116.403121547389;4117.649999750025;4122.91754164918;4126.112885729583;4136.110736191733;5975.043992961106;5993.9400605993815;5994.100884867261;5995.520358371364;6014.218151640259;5378.677279363251;5500.367457742371;5501.724913754297;5529.060059789846;5542.528885044776;6656.134702488694;6657.700403481855;6670.6331151786635;6685.765998190089;6686.93313066868;4551.340055691906;4571;4584.472785629662;4592.127495775825;4597.034622729231;6772.796816095525;6881.759138430181;6947.548409353376;6953.652317384111;6965.895511567331;4655.324977878188;4673.6728429009645;4690.624750019991;4699.624030077585;4711.976440117777;4734.171519983989;4738.597219236334;4744.169770290186;4744.667873248839;4747.287906813936;5494.835154945358;5496.835094947158;5499.285092937893;5499.780008799683;5506.834794956158;6554.279029306773;6671.299513551105;6671.964256263389;6676.766313179015;6691.397774200345;1648.8021437427346;1664.9916750416412;1692.7884014498188;1693.898366098038;1695.271033455626;1118.0440723181725;1121.2095472691733;1126.8366086917351;1132.9546818127346;1140.7205234717546;6299.244090709144;6302.338254483213;6310.779122730774;6311.084892690534;6319.968400158062;6806.7957961261245;6814.454843612499;6831.385175334244;6839.110915580943;6840.452763778886;6178.382161783786;6241.781537646251;6303.653299068504;6305.621662700252;6316.684165791692;3714.0714821294678;3725.9254814904093;3726.5341832270965;3737.4020156774786;3738.420544815558;7084.681189346492;7141.071660684078;7144.428445724329;7144.821379465555;7150.713971441188;6893.103896493524;6933.965330173418;6977.197622273402;6977.197622273504;6981.616011119336;7234.710611575478;7246.094238220223;7246.60143692102;7260.455465840083;7273.309035641606;6961.547499412522;6968.024476573182;6974.860502790018;6988.720451182099;6989.916562932754;6768.255491895789;6819.829504262433;6856.040154378491;6865.107536020286;6866.931330686829;7238.963805180941;7253.165885923187;7253.419726421979;7265.382442492447;7286.708531658886;4665.626749859935;4691.50739172382;4715.504871988392;4724.291356296583;4729.976350118227;6820.488463365168;6956.40870526011;6964.338387853146;6989.650517474208;7016.929830701628;6754.898676519758;6779.288174741581;6780.69486873082;6786.69459874297;6797.830054248683;6727.629980351127;6782.457403407617;6788.2193547742645;6788.7284508619105;6799.796006119825;6467.191601049869;6586.967065164644;6617.43751781104;6624.503162262946;6647.966760166169;6729.629870357177;6787.864242715217;6801.2178599461695;6813.318668133147;6822.454203663794;6628.07206991012;6633.767818126343;6640.9335906642245;6642.933570664231;6645.933540664725 22:16:04 INFO - PROCESS | 6379 | |5;yui.html;702.9771682202389;714.9285071492851;757.5341165183412;799.7041094794927;818.447547905164;12323.630291091271;12526.060545459082;12528;12530.997520198385;12595.937020314908;12602.117851750381;12605.684857878558;12667.303298318611;12693.682657933556;12749.426275817586;801.6873419366452;819.1358117186365;832.3798769916391;835.3484282259817;837.4472847920374;820.5609998650723;825.3727167352826;825.7110011495959;827.2389401750404;833.6623667414676;871.2768402226137;871.5337294547387;872.5593575244493;873.76845136039;874.6326542851986;859.2867919626757;864.7838040489909;865.8701194820795;866.0257210638032;867.1848462445345;639.9072134540512;640.1645852162926;640.6444423345042;641.7721708793358;643.8969764837603;13578.185308881499;13718.65703357424;13742.312884355842;13761.793573096411;13784.724305513833;11129.610463633733;11399.886001140048;11593.478293476814;11900.404979750978;12829.42267597951;10066.29535932485;10337.74155646115;10484.266101372907;10623.521941512574;10681.626143085032;3428.9485657715154;3522.5420695309444;3566.5185199997927;3568.1614820517157;3569.7501174917766;47133.293000605016;47484.52515474836;47670.761646191546;47714.04571908577;47838.28242576364;9556.474393908402;9653.131218190256;9893.60425582983;10402.843957340647;10988.945055274833;18650.626987460175;18729.719054214198;18774.906125469286;18789.718154227696;18846.905765471085;7463.813404664927;7468.663910124057;7601.847963040708;7642.197569255148;7802.570858602831;4274.700770946004;4346.978265108654;4420.513743488214;4423.955760442419;4517.570830771071;3140.811551306929;3143.339898621269;3151.779375443697;3157.905262842118;3170.7304879085073;557.6876948908624;559.6949662433983;562.6005536069355;566.6260268222953;570.823044856096;636.8885445047098;638.2532437048665;645.2869579115104;665.7137430904661;666.213867636194;8449.57752112392;8497.2777313929;8518.318534517224;8650.394472386999;9310.95344523273;620.1503939602773;628.5191828251392;643.4980715042275;656.5896314803248;713.162034609332;3880.476135721698;3996.980015099906;4080.714349995472;4108.958910410917;4194.30793919006;55609.44390556124;60060.39939600635;60249.69875150596;60365.396346036854;60706.69646651827;52585.47414525882;52824.20763688471;53725.731371342896;54059.18911216335;54332;47749.76125119421;47948.7602561985;48119.75940120347;48486;49098.263526047136;7984.441089123938;8032.638531266224;8497.957510212409;8669.30645548342;9004.81990360176;32397.676023239466;32681.509777352883;32830.17924551905;34388;34532.48201277033;44243.11513769771;48485.63331457384;48625.75687121542;48769.756151219015;48918;10511.369317840954;10799.40603266828;11073.822171473705;11122.165837562054;11166.49750761234;11936.641900742992;12026.879731202576;12504.562340318045;12524.749505009666;12748;10794.460276986276;10888.401137937173;11114.777044590952;11118.388488633203;11396.772064558829;10390.844137337795;10662.786744264917;10710.946445267724;10760.677179684622;10764.623238186627;10786.514606842555;10955.397453139834;11091.778164436828;11114.333140011626;11336.659900203007;9681.08029737202;9897.35667181631;9924.206063515046;9938.204943604349;10306.742331441774;9166.770830729285;9411.858822117536;9412.294077944045;9591.28065395112;9628.32601717873 22:16:04 INFO - PROCESS | 6379 | __end_tp_report 22:16:04 INFO - PROCESS | 6379 | __start_cc_report 22:16:04 INFO - PROCESS | 6379 | _x_x_mozilla_cycle_collect,315 22:16:04 INFO - PROCESS | 6379 | __end_cc_report 22:16:04 INFO - PROCESS | 6379 | __startTimestamp1451110564630__endTimestamp 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | ------- Summary: start ------- 22:16:04 INFO - PROCESS | 6379 | Number of tests: 6 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#0] dojo.html Cycles:165 Average:5240.20 Median:5450.10 stddev:573.13 (10.5%) stddev-sans-first:551.56 22:16:04 INFO - PROCESS | 6379 | Values: 3177.0 3189.0 3222.6 3230.8 3249.0 5133.2 5193.5 5193.9 5196.8 5212.3 5190.6 5219.1 5236.4 5245.6 5283.2 4426.5 4749.6 4892.0 4905.5 4925.9 4752.5 4846.2 4866.4 4889.6 4917.6 4710.1 4776.5 4782.9 4783.6 4810.9 4724.5 4730.9 4763.7 4765.4 4768.9 4753.0 4754.0 4774.5 4776.5 4785.2 4958.9 5068.4 5079.6 5081.9 5087.7 5661.5 5718.1 5718.6 5742.2 5778.7 5647.4 5662.6 5665.3 5683.1 5701.8 5286.6 5311.9 5334.3 5338.9 5374.0 5757.3 5765.1 5771.2 5782.7 5783.2 5471.7 5496.4 5533.3 5539.2 5573.2 5442.2 5557.1 5573.9 5706.8 5803.2 5597.7 5603.5 5603.7 5606.0 5616.3 5576.6 5596.3 5596.7 5598.4 5601.5 4309.0 4359.7 4378.5 4398.9 4457.6 3869.8 3886.6 3907.5 3929.1 3930.7 5189.5 5249.6 5261.6 5265.6 5286.1 5493.6 5580.3 5602.9 5631.5 5647.1 5309.4 5324.3 5355.0 5360.1 5363.2 4909.0 4945.5 4946.7 4946.8 4977.6 5752.6 5837.2 5851.2 5895.5 5959.4 5617.0 5645.4 5661.9 5677.5 5737.4 5810.2 5850.6 5850.9 5857.3 5864.6 5476.4 5498.8 5565.5 5586.9 5590.4 5623.0 5654.1 5658.1 5674.0 5682.1 5506.5 5511.5 5523.2 5525.3 5533.6 5407.8 5489.4 5532.1 5592.8 5664.9 5444.0 5446.7 5450.1 5466.2 5475.5 5545.6 5565.9 5570.4 5581.0 5626.6 5248.2 5304.3 5368.7 5469.9 5571.7 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#1] ext.html Cycles:180 Average:43974.17 Median:35595.05 stddev:73062.78 (205.3%) stddev-sans-first:73194.99 22:16:04 INFO - PROCESS | 6379 | Values: 550.8 589.7 598.9 603.0 606.5 35820.8 35954.0 36079.8 36154.8 36284.6 38922.0 39399.0 39437.2 39628.4 39751.2 8420.3 8652.4 8667.2 8680.4 8706.9 8459.6 8518.4 8536.4 8644.0 8683.2 8623.1 8684.1 8694.2 8717.4 8729.0 8630.0 8719.6 8727.7 8730.2 8738.4 8587.4 8600.8 8684.3 8695.2 8708.3 39308.4 39611.2 39880.0 39927.6 39971.6 3329.4 3361.5 3531.9 3709.1 3914.1 29053.1 29301.6 29421.0 29615.9 29737.4 3708.6 3861.9 3925.0 4035.4 4084.4 190451.0 190789.0 190859.0 191163.0 191410.0 53428.0 54396.7 57808.4 58077.7 60137.4 53920.7 54001.5 54113.0 54163.7 54172.2 15795.1 15796.1 15826.9 15852.9 15957.6 11073.8 11112.8 11131.8 11138.1 11169.7 19156.7 19609.3 20364.7 20374.4 20408.4 7338.5 7339.9 7369.2 7418.6 7568.5 941.2 953.9 970.2 995.5 1010.1 27848.6 28032.0 28130.9 28260.0 28303.2 1022.2 1051.8 1073.8 1091.9 1114.2 14717.3 14728.6 14730.8 14911.7 15087.5 323999.0 326381.0 326822.0 327476.0 328483.0 51300.5 51616.5 51624.5 51697.5 51751.5 1338.5 1345.9 1347.1 1352.4 1354.9 26253.5 27445.6 27616.9 27832.6 28020.6 46238.0 46418.3 46540.0 46795.5 47049.0 299409.0 300429.0 300612.0 301000.0 302688.0 31802.8 31970.5 32191.2 32390.8 32545.3 37750.6 37827.1 38500.4 38759.2 39232.6 34568.3 34858.8 34958.7 35311.6 35691.3 35041.5 35437.8 35498.8 35885.6 35917.5 33856.3 34462.7 34966.5 34991.8 35191.5 30794.0 31539.0 32076.2 32246.8 32335.5 23181.7 23403.0 23423.9 24253.6 24671.6 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#2] jquery.html Cycles:180 Average:23323.44 Median:18071.04 stddev:64183.98 (355.2%) stddev-sans-first:64340.87 22:16:04 INFO - PROCESS | 6379 | Values: 359.0 360.8 361.2 362.2 364.5 14108.2 14387.9 16629.7 16919.6 17565.9 14682.2 14766.4 14817.7 14818.0 14824.4 5317.8 5371.2 5472.4 5476.2 5482.6 5431.6 5468.1 5477.8 5482.2 5482.4 5320.0 5450.1 5534.9 5543.0 5545.1 5486.5 5500.6 5511.6 5514.0 5532.9 4857.2 4924.1 4936.2 4947.0 4950.5 19878.5 19911.8 20066.0 20328.2 20579.8 2165.4 2199.2 2306.5 2399.4 2417.9 9304.3 9425.8 9447.7 9570.6 9664.7 1792.1 1803.1 1835.6 1913.4 1979.5 58777.0 60539.4 61197.0 61438.4 61856.7 10284.3 10297.6 10373.5 10405.1 10461.8 11924.8 12437.8 12485.8 13573.3 13611.5 7073.2 7264.0 7360.4 7383.1 7405.9 6941.5 6950.4 6955.5 6975.7 7009.9 4307.5 4337.5 4338.1 4343.3 4345.0 1821.7 1847.6 1847.8 1889.1 1902.7 845.4 893.8 992.5 1060.3 1089.1 16820.9 17158.9 17259.9 17284.0 17787.6 921.6 986.2 986.7 998.3 1017.9 9683.0 9883.7 9908.5 9934.1 9962.0 137216.0 137748.0 469960.0 494288.0 497933.0 78704.0 79292.6 82633.0 84416.6 86321.9 1124.8 1160.9 1176.1 1176.3 1185.5 15142.5 15230.2 15261.7 15264.0 15299.5 30615.2 32551.5 33510.7 33742.8 35783.1 41035.6 43336.6 43430.3 44216.8 46963.5 9439.0 9727.0 9897.4 9912.5 10001.4 11605.5 11729.1 11742.6 11810.1 12127.4 14339.3 14404.9 14464.3 14482.7 14931.3 14155.4 14412.9 14615.8 14741.7 15213.0 15217.8 15378.7 15413.2 15749.6 15767.7 9776.8 9866.6 9924.4 9971.6 9972.9 15016.4 15073.9 15170.3 15281.3 15393.5 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#3] mootools.html Cycles:180 Average:5184.72 Median:6143.94 stddev:2664.26 (43.4%) stddev-sans-first:2656.72 22:16:04 INFO - PROCESS | 6379 | Values: 1421.5 1458.1 1623.3 1756.1 1794.1 6439.1 6452.4 7298.9 7431.0 7452.5 7100.6 7189.2 7221.5 7313.6 7322.2 2222.8 2246.7 2251.7 2255.5 2260.1 2229.3 2243.2 2317.5 2318.5 2320.2 2233.6 2238.6 2266.0 2272.9 2295.3 2224.3 2227.5 2277.2 2280.9 2282.0 2245.2 2265.3 2266.3 2272.2 2276.4 7324.9 7332.3 7391.9 7418.3 7422.9 4509.8 4609.5 4616.3 4629.3 4632.4 2983.5 2994.1 3068.2 3095.7 3096.1 930.7 947.0 973.3 984.8 995.7 10082.0 10083.5 10105.1 10110.1 10128.2 4123.1 4157.3 4191.1 4206.4 4210.2 8633.9 8677.7 8687.4 8693.2 8710.7 4620.0 4639.4 4664.0 4693.4 4693.8 4134.8 4170.1 4224.4 4236.4 4243.1 3378.1 3392.8 3395.2 3400.8 3426.4 1014.5 1024.5 1029.1 1036.8 1047.3 1128.4 1167.5 1169.9 1204.9 1257.6 6540.5 6569.8 6574.2 6623.1 6631.0 475.9 476.5 486.3 490.4 490.7 5412.9 5434.5 5447.6 5457.1 5474.1 8657.7 8729.6 8986.2 9014.2 9030.4 8786.4 8895.5 8907.2 8981.7 8989.4 6958.4 7051.0 7086.1 7091.1 7105.8 6810.3 6837.6 6840.3 6851.5 6857.3 7865.9 8006.8 8020.7 8082.4 8127.2 7939.6 8177.5 8194.2 8213.7 8295.7 5983.0 6012.2 6369.0 6534.6 6547.0 6984.4 7080.8 7083.2 7100.2 7117.2 6531.9 6575.6 6822.3 6823.6 6869.5 6395.1 6448.8 6453.1 6521.0 6549.9 6739.9 6779.2 6782.6 6790.4 6810.9 6044.1 6110.3 6143.9 6144.0 6228.8 6133.3 6176.8 6186.3 6193.7 6194.4 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#4] prototype.html Cycles:180 Average:5580.06 Median:6298.37 stddev:1701.46 (27.0%) stddev-sans-first:1660.04 22:16:04 INFO - PROCESS | 6379 | Values: 334.1 336.3 341.9 343.3 343.5 6259.8 6278.2 6284.2 6286.6 6379.8 6216.6 6266.6 6267.4 6284.7 6297.5 4750.1 4773.1 4780.0 4790.8 4796.2 4787.6 4789.1 4794.4 4794.9 4795.9 4653.1 4743.9 4746.8 4751.0 4756.9 4738.6 4741.4 4753.9 4758.7 4773.9 4116.4 4117.6 4122.9 4126.1 4136.1 5975.0 5993.9 5994.1 5995.5 6014.2 5378.7 5500.4 5501.7 5529.1 5542.5 6656.1 6657.7 6670.6 6685.8 6686.9 4551.3 4571.0 4584.5 4592.1 4597.0 6772.8 6881.8 6947.5 6953.7 6965.9 4655.3 4673.7 4690.6 4699.6 4712.0 4734.2 4738.6 4744.2 4744.7 4747.3 5494.8 5496.8 5499.3 5499.8 5506.8 6554.3 6671.3 6672.0 6676.8 6691.4 1648.8 1665.0 1692.8 1693.9 1695.3 1118.0 1121.2 1126.8 1133.0 1140.7 6299.2 6302.3 6310.8 6311.1 6320.0 6806.8 6814.5 6831.4 6839.1 6840.5 6178.4 6241.8 6303.7 6305.6 6316.7 3714.1 3725.9 3726.5 3737.4 3738.4 7084.7 7141.1 7144.4 7144.8 7150.7 6893.1 6934.0 6977.2 6977.2 6981.6 7234.7 7246.1 7246.6 7260.5 7273.3 6961.5 6968.0 6974.9 6988.7 6989.9 6768.3 6819.8 6856.0 6865.1 6866.9 7239.0 7253.2 7253.4 7265.4 7286.7 4665.6 4691.5 4715.5 4724.3 4730.0 6820.5 6956.4 6964.3 6989.7 7016.9 6754.9 6779.3 6780.7 6786.7 6797.8 6727.6 6782.5 6788.2 6788.7 6799.8 6467.2 6587.0 6617.4 6624.5 6648.0 6729.6 6787.9 6801.2 6813.3 6822.5 6628.1 6633.8 6640.9 6642.9 6645.9 22:16:04 INFO - PROCESS | 6379 | 22:16:04 INFO - PROCESS | 6379 | [#5] yui.html Cycles:180 Average:13939.85 Median:48034.26 stddev:16452.06 (34.3%) stddev-sans-first:16468.18 22:16:04 INFO - PROCESS | 6379 | Values: 703.0 714.9 757.5 799.7 818.4 12323.6 12526.1 12528.0 12531.0 12595.9 12602.1 12605.7 12667.3 12693.7 12749.4 801.7 819.1 832.4 835.3 837.4 820.6 825.4 825.7 827.2 833.7 871.3 871.5 872.6 873.8 874.6 859.3 864.8 865.9 866.0 867.2 639.9 640.2 640.6 641.8 643.9 13578.2 13718.7 13742.3 13761.8 13784.7 11129.6 11399.9 11593.5 11900.4 12829.4 10066.3 10337.7 10484.3 10623.5 10681.6 3428.9 3522.5 3566.5 3568.2 3569.8 47133.3 47484.5 47670.8 47714.0 47838.3 9556.5 9653.1 9893.6 10402.8 10988.9 18650.6 18729.7 18774.9 18789.7 18846.9 7463.8 7468.7 7601.8 7642.2 7802.6 4274.7 4347.0 4420.5 4424.0 4517.6 3140.8 3143.3 3151.8 3157.9 3170.7 557.7 559.7 562.6 566.6 570.8 636.9 638.3 645.3 665.7 666.2 8449.6 8497.3 8518.3 8650.4 9311.0 620.2 628.5 643.5 656.6 713.2 3880.5 3997.0 4080.7 4109.0 4194.3 55609.4 60060.4 60249.7 60365.4 60706.7 52585.5 52824.2 53725.7 54059.2 54332.0 47749.8 47948.8 48119.8 48486.0 49098.3 7984.4 8032.6 8498.0 8669.3 9004.8 32397.7 32681.5 32830.2 34388.0 34532.5 44243.1 48485.6 48625.8 48769.8 48918.0 10511.4 10799.4 11073.8 11122.2 11166.5 11936.6 12026.9 12504.6 12524.7 12748.0 10794.5 10888.4 11114.8 11118.4 11396.8 10390.8 10662.8 10710.9 10760.7 10764.6 10786.5 10955.4 11091.8 11114.3 11336.7 9681.1 9897.4 9924.2 9938.2 10306.7 9166.8 9411.9 9412.3 9591.3 9628.3 22:16:04 INFO - PROCESS | 6379 | -------- Summary: end -------- 22:16:04 INFO - PROCESS | 6379 | 22:16:05 INFO - TEST-INFO | 6379: exit 0 22:16:05 INFO - TEST-OK | dromaeo_css | took 1110026ms 22:16:05 INFO - TEST-START | kraken 22:16:05 INFO - operating with platform_type : linux_ 22:16:05 INFO - Initialising browser for kraken test... 22:16:05 INFO - TEST-INFO | started process 6616 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFEzT9g/profile http://localhost:41746/getInfo.html) 22:16:09 INFO - PROCESS | 6616 | __metrics Screen width/height:1600/1200 22:16:09 INFO - PROCESS | 6616 | colorDepth:24 22:16:09 INFO - PROCESS | 6616 | Browser inner width/height: 1024/697 22:16:09 INFO - PROCESS | 6616 | __metrics 22:16:09 INFO - PROCESS | 6616 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:16:10 INFO - TEST-INFO | 6616: exit 0 22:16:10 INFO - Browser initialized. 22:16:10 INFO - Running cycle 1/1 for kraken test... 22:16:10 INFO - TEST-INFO | started process 6740 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFEzT9g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:16:22 INFO - PROCESS | 6740 | RSS: Main: 149712896 22:16:22 INFO - PROCESS | 6740 | 22:16:24 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-beat-detection) 22:16:25 INFO - PROCESS | 6740 | RSS: Main: 150986752 22:16:25 INFO - PROCESS | 6740 | 22:16:27 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-dft) 22:16:28 INFO - PROCESS | 6740 | RSS: Main: 151756800 22:16:28 INFO - PROCESS | 6740 | 22:16:31 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-fft) 22:16:31 INFO - PROCESS | 6740 | RSS: Main: 145723392 22:16:31 INFO - PROCESS | 6740 | 22:16:34 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41746/tests/kraken/driver.html?testName=audio-oscillator) 22:16:34 INFO - PROCESS | 6740 | RSS: Main: 146718720 22:16:34 INFO - PROCESS | 6740 | 22:16:37 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:16:37 INFO - PROCESS | 6740 | RSS: Main: 148545536 22:16:37 INFO - PROCESS | 6740 | 22:16:40 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-darkroom) 22:16:41 INFO - PROCESS | 6740 | RSS: Main: 148213760 22:16:41 INFO - PROCESS | 6740 | 22:16:44 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41746/tests/kraken/driver.html?testName=imaging-desaturate) 22:16:45 INFO - PROCESS | 6740 | RSS: Main: 148451328 22:16:45 INFO - PROCESS | 6740 | 22:16:47 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41746/tests/kraken/driver.html?testName=json-parse-financial) 22:16:48 INFO - PROCESS | 6740 | RSS: Main: 148967424 22:16:48 INFO - PROCESS | 6740 | 22:16:50 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:16:50 INFO - PROCESS | 6740 | RSS: Main: 148328448 22:16:50 INFO - PROCESS | 6740 | 22:16:52 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:53 INFO - PROCESS | 6740 | RSS: Main: 148680704 22:16:53 INFO - PROCESS | 6740 | 22:16:55 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:55 INFO - PROCESS | 6740 | RSS: Main: 148979712 22:16:55 INFO - PROCESS | 6740 | 22:16:58 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:58 INFO - PROCESS | 6740 | RSS: Main: 149417984 22:16:58 INFO - PROCESS | 6740 | 22:17:01 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:17:01 INFO - PROCESS | 6740 | RSS: Main: 148664320 22:17:01 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | Cycle 1(1): loaded http://localhost:41746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41746/tests/kraken/driver.html?testName=ai-astar) 22:17:03 INFO - PROCESS | 6740 | RSS: Main: 149094400 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | __start_tp_report 22:17:03 INFO - PROCESS | 6740 | _x_x_mozilla_page_load 22:17:03 INFO - PROCESS | 6740 | _x_x_mozilla_page_load_details 22:17:03 INFO - PROCESS | 6740 | |i|pagename|runs| 22:17:03 INFO - PROCESS | 6740 | |0;ai-astar;112;108;111;111;112;123;113;110;112;113 22:17:03 INFO - PROCESS | 6740 | |1;audio-beat-detection;154;124;154;159;129;153;158;128;161;128 22:17:03 INFO - PROCESS | 6740 | |2;audio-dft;161;162;163;162;161;163;162;170;168;160 22:17:03 INFO - PROCESS | 6740 | |3;audio-fft;72;72;76;73;73;70;71;144;75;72 22:17:03 INFO - PROCESS | 6740 | |4;audio-oscillator;96;96;145;95;95;96;147;95;102;143 22:17:03 INFO - PROCESS | 6740 | |5;imaging-gaussian-blur;110;111;110;109;110;110;110;110;110;111 22:17:03 INFO - PROCESS | 6740 | |6;imaging-darkroom;146;147;147;147;147;146;147;147;147;147 22:17:03 INFO - PROCESS | 6740 | |7;imaging-desaturate;96;97;96;98;97;96;97;97;98;97 22:17:03 INFO - PROCESS | 6740 | |8;json-parse-financial;62;61;61;59;60;60;60;64;56;56 22:17:03 INFO - PROCESS | 6740 | |9;json-stringify-tinderbox;67;68;68;68;68;68;69;68;67;67 22:17:03 INFO - PROCESS | 6740 | |10;stanford-crypto-aes;86;87;89;88;93;87;94;87;94;88 22:17:03 INFO - PROCESS | 6740 | |11;stanford-crypto-ccm;128;120;115;120;128;119;129;129;120;126 22:17:03 INFO - PROCESS | 6740 | |12;stanford-crypto-pbkdf2;140;156;150;148;156;140;158;148;152;150 22:17:03 INFO - PROCESS | 6740 | |13;stanford-crypto-sha256-iterative;67;67;72;70;70;67;70;68;67;69 22:17:03 INFO - PROCESS | 6740 | __end_tp_report 22:17:03 INFO - PROCESS | 6740 | __start_cc_report 22:17:03 INFO - PROCESS | 6740 | _x_x_mozilla_cycle_collect,760 22:17:03 INFO - PROCESS | 6740 | __end_cc_report 22:17:03 INFO - PROCESS | 6740 | __startTimestamp1451110623939__endTimestamp 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | ------- Summary: start ------- 22:17:03 INFO - PROCESS | 6740 | Number of tests: 14 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.22 22:17:03 INFO - PROCESS | 6740 | Values: 112.0 108.0 111.0 111.0 112.0 123.0 113.0 110.0 112.0 113.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:154.00 stddev:15.35 (10.0%) stddev-sans-first:15.92 22:17:03 INFO - PROCESS | 6740 | Values: 154.0 124.0 154.0 159.0 129.0 153.0 158.0 128.0 161.0 128.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.22 (2.0%) stddev-sans-first:3.32 22:17:03 INFO - PROCESS | 6740 | Values: 161.0 162.0 163.0 162.0 161.0 163.0 162.0 170.0 168.0 160.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#3] audio-fft Cycles:10 Average:79.80 Median:72.50 stddev:22.63 (31.2%) stddev-sans-first:23.82 22:17:03 INFO - PROCESS | 6740 | Values: 72.0 72.0 76.0 73.0 73.0 70.0 71.0 144.0 75.0 72.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.00 stddev:23.57 (24.8%) stddev-sans-first:24.37 22:17:03 INFO - PROCESS | 6740 | Values: 96.0 96.0 145.0 95.0 95.0 96.0 147.0 95.0 102.0 143.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:17:03 INFO - PROCESS | 6740 | Values: 110.0 111.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 22:17:03 INFO - PROCESS | 6740 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 22:17:03 INFO - PROCESS | 6740 | Values: 96.0 97.0 96.0 98.0 97.0 96.0 97.0 97.0 98.0 97.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#8] json-parse-financial Cycles:10 Average:59.90 Median:60.50 stddev:2.47 (4.1%) stddev-sans-first:2.50 22:17:03 INFO - PROCESS | 6740 | Values: 62.0 61.0 61.0 59.0 60.0 60.0 60.0 64.0 56.0 56.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 22:17:03 INFO - PROCESS | 6740 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 67.0 67.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:88.50 stddev:3.13 (3.5%) stddev-sans-first:3.08 22:17:03 INFO - PROCESS | 6740 | Values: 86.0 87.0 89.0 88.0 93.0 87.0 94.0 87.0 94.0 88.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:127.00 stddev:5.13 (4.0%) stddev-sans-first:5.16 22:17:03 INFO - PROCESS | 6740 | Values: 128.0 120.0 115.0 120.0 128.0 119.0 129.0 129.0 120.0 126.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:6.21 (4.1%) stddev-sans-first:5.49 22:17:03 INFO - PROCESS | 6740 | Values: 140.0 156.0 150.0 148.0 156.0 140.0 158.0 148.0 152.0 150.0 22:17:03 INFO - PROCESS | 6740 | 22:17:03 INFO - PROCESS | 6740 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:1.77 (2.5%) stddev-sans-first:1.76 22:17:03 INFO - PROCESS | 6740 | Values: 67.0 67.0 72.0 70.0 70.0 67.0 70.0 68.0 67.0 69.0 22:17:03 INFO - PROCESS | 6740 | -------- Summary: end -------- 22:17:03 INFO - PROCESS | 6740 | 22:17:04 INFO - TEST-INFO | 6740: exit 0 22:17:04 INFO - TEST-OK | kraken | took 59515ms 22:17:04 INFO - TEST-START | v8_7 22:17:04 INFO - operating with platform_type : linux_ 22:17:04 INFO - Initialising browser for v8_7 test... 22:17:04 INFO - TEST-INFO | started process 7029 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxSqJyI/profile http://localhost:41746/getInfo.html) 22:17:09 INFO - PROCESS | 7029 | __metrics Screen width/height:1600/1200 22:17:09 INFO - PROCESS | 7029 | colorDepth:24 22:17:09 INFO - PROCESS | 7029 | Browser inner width/height: 1024/697 22:17:09 INFO - PROCESS | 7029 | __metrics 22:17:09 INFO - PROCESS | 7029 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:17:10 INFO - TEST-INFO | 7029: exit 0 22:17:10 INFO - Browser initialized. 22:17:10 INFO - Running cycle 1/1 for v8_7 test... 22:17:10 INFO - TEST-INFO | started process 7151 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxSqJyI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:17:21 INFO - PROCESS | 7151 | RSS: Main: 149073920 22:17:21 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | Cycle 1(1): loaded http://localhost:41746/tests/v8_7/run.html (next: http://localhost:41746/tests/v8_7/run.html) 22:17:43 INFO - PROCESS | 7151 | RSS: Main: 146386944 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | __start_tp_report 22:17:43 INFO - PROCESS | 7151 | _x_x_mozilla_page_load 22:17:43 INFO - PROCESS | 7151 | _x_x_mozilla_page_load_details 22:17:43 INFO - PROCESS | 7151 | |i|pagename|runs| 22:17:43 INFO - PROCESS | 7151 | |0;Richards;167.61649346295675 22:17:43 INFO - PROCESS | 7151 | |1;DeltaBlue;197.35543714229328 22:17:43 INFO - PROCESS | 7151 | |2;Encrypt;282.326369282891 22:17:43 INFO - PROCESS | 7151 | |3;Decrypt;5246.073298429319 22:17:43 INFO - PROCESS | 7151 | |4;RayTrace;1060.3813559322034 22:17:43 INFO - PROCESS | 7151 | |5;Earley;754.1478129713424 22:17:43 INFO - PROCESS | 7151 | |6;Boyer;11904.761904761905 22:17:43 INFO - PROCESS | 7151 | |7;RegExp;25425 22:17:43 INFO - PROCESS | 7151 | |8;Splay;608.272506082725 22:17:43 INFO - PROCESS | 7151 | |9;NavierStokes;4850.241545893719 22:17:43 INFO - PROCESS | 7151 | __end_tp_report 22:17:43 INFO - PROCESS | 7151 | __startTimestamp1451110663505__endTimestamp 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | ------- Summary: start ------- 22:17:43 INFO - PROCESS | 7151 | Number of tests: 10 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 167.6 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#1] DeltaBlue Cycles:1 Average:197.36 Median:197.36 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 197.4 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#2] Encrypt Cycles:1 Average:282.33 Median:282.33 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 282.3 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 5246.1 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#4] RayTrace Cycles:1 Average:1060.38 Median:1060.38 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 1060.4 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#5] Earley Cycles:1 Average:754.15 Median:754.15 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 754.1 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#6] Boyer Cycles:1 Average:11904.76 Median:11904.76 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 11904.8 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 25425.0 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#8] Splay Cycles:1 Average:608.27 Median:608.27 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 608.3 22:17:43 INFO - PROCESS | 7151 | 22:17:43 INFO - PROCESS | 7151 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 22:17:43 INFO - PROCESS | 7151 | Values: 4850.2 22:17:43 INFO - PROCESS | 7151 | -------- Summary: end -------- 22:17:43 INFO - PROCESS | 7151 | 22:17:44 INFO - TEST-INFO | 7151: exit 0 22:17:44 INFO - TEST-OK | v8_7 | took 39518ms 22:17:44 INFO - SUITE-END | took 1209s 22:17:44 INFO - Completed test suite (00:20:09) 22:17:44 INFO - Working with test: dromaeo_css 22:17:44 INFO - Generating results file: dromaeo_css 22:17:44 INFO - Working with test: kraken 22:17:44 INFO - Generating results file: kraken 22:17:44 INFO - javascript benchmark 22:17:44 INFO - Working with test: v8_7 22:17:44 INFO - Generating results file: v8_7 22:17:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:17:44 INFO - process_Request line: dromaeo_css 6913.59 graph.html#tests=[[72,1,43]] 22:17:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:44 INFO - process_Request line: kraken 1524.00 graph.html#tests=[[232,1,43]] 22:17:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:17:44 INFO - process_Request line: v8_7 21137.74 graph.html#tests=[[230,1,43]] 22:17:44 INFO - RETURN: dromaeo_css: 6913.59 22:17:44 INFO - RETURN: kraken: 1524.00 22:17:44 INFO - RETURN: v8_7: 21137.74 22:17:44 INFO - javascript benchmark 22:17:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3177.0, 3188.9521657175146, 3222.5810644616195, 3230.757693173012, 3249.0252924122756, 5133.153029750087, 5193.480651934809, 5193.922091168631, 5196.792128314873, 5212.2963399941, 5190.636655434121, 5219.086659834523, 5236.423993360727, 5245.606579506533, 5283.181106928432, 4426.490953540336, 4749.620030397568, 4892.0, 4905.533974272438, 4925.926111108336, 4752.477227504972, 4846.151923413407, 4866.440359358684, 4889.608831293488, 4917.631177661672, 4710.105080034799, 4776.522347765213, 4782.856514304576, 4783.617310615143, 4810.879728006793, 4724.480307166244, 4730.905381892378, 4763.666543341968, 4765.428148622153, 4768.904621907577, 4752.952470475286, 4753.9762301188275, 4774.4509381420885, 4776.546228108324, 4785.21044027735, 4958.900821983576, 5068.3917929848285, 5079.619028572835, 5081.872953176163, 5087.720175390352, 5661.518770904437, 5718.085106382959, 5718.628289161233, 5742.224799652077, 5778.711064446803, 5647.37878833328, 5662.6036177467595, 5665.291838520185, 5683.090705487143, 5701.77192912283, 5286.550643195333, 5311.946880531223, 5334.253204551366, 5338.8665283367445, 5374.032674118696, 5757.251557297524, 5765.106408506688, 5771.220885180531, 5782.6819524925695, 5783.248177736868, 5471.699056551928, 5496.367917689437, 5533.335999680065, 5539.224508568804, 5573.164025396142, 5442.2380866678695, 5557.110862262019, 5573.944260557424, 5706.80026199081, 5803.216565763568, 5597.74810133545, 5603.5237004854225, 5603.691796951125, 5606.018946684314, 5616.269884914935, 5576.581756368289, 5596.3284405871555, 5596.748146333425, 5598.356189038232, 5601.5238704709745, 4308.978455107705, 4359.716618419792, 4378.496472905593, 4398.890027749332, 4457.621102206284, 3869.787161706077, 3886.630770076838, 3907.5115610548683, 3929.115948911472, 3930.6855451563806, 5189.455107213764, 5249.553787927993, 5261.631685782035, 5265.552428043583, 5286.07493688603, 5493.560515158778, 5580.274564306615, 5602.85992850182, 5631.493165615114, 5647.068233741469, 5309.36287645485, 5324.334458192726, 5355.0, 5360.088784906575, 5363.222332761806, 4908.9754551227015, 4945.480724523945, 4946.653734238641, 4946.826861059845, 4977.626677999165, 5752.626079304831, 5837.182794408786, 5851.239338885917, 5895.498882594941, 5959.404059594092, 5616.971915140398, 5645.435456454322, 5661.886762264814, 5677.545796336366, 5737.368889422244, 5810.244668193108, 5850.5904586678525, 5850.859082478876, 5857.26784151981, 5864.560157988253, 5476.3702174250475, 5498.80754173602, 5565.526930210977, 5586.860328491658, 5590.440955904377, 5623.0, 5654.067078932095, 5658.094704847204, 5673.971630141823, 5682.062459694104, 5506.476884695948, 5511.5315198207, 5523.226748255328, 5525.336959564878, 5533.5849811263515, 5407.78368865241, 5489.3687225969525, 5532.0595498766115, 5592.832215033555, 5664.886702265849, 5444.047291724011, 5446.700431476307, 5450.1007333789485, 5466.1527463243265, 5475.479829416199, 5545.584081194007, 5565.944340556543, 5570.359408668055, 5580.972095139661, 5626.634268772516, 5248.160294352885, 5304.283921670525, 5368.651037682538, 5469.863253418696, 5571.693556854412], "unit": "score", "name": "dojo.html", "value": 5204.011691366082}, {"lowerIsBetter": false, "replicates": [550.7604192176403, 589.6579983609504, 598.9311229208641, 602.9629038054545, 606.4875180472502, 35820.820895895515, 35954.0, 36079.819600902025, 36154.81922590383, 36284.63715362846, 38922.0, 39399.0, 39437.21125577487, 39628.405573916345, 39751.20497590054, 8420.326373890104, 8652.351073669468, 8667.17661822126, 8680.435771674822, 8706.869396959051, 8459.577021148949, 8518.446300990447, 8536.359773017017, 8644.049154592989, 8683.175098365646, 8623.13768623139, 8684.13158684133, 8694.174053464942, 8717.433366831136, 8728.956355218215, 8629.95685021574, 8719.60761765722, 8727.650893964234, 8730.214280714703, 8738.388312818042, 8587.355948303839, 8600.827983440297, 8684.305255579538, 8695.173958473935, 8708.30333573319, 39308.41037384442, 39611.20777584432, 39880.0, 39927.60072399297, 39971.600283997366, 3329.3674201901563, 3361.5125806757883, 3531.876384326536, 3709.1283548366114, 3914.080191155076, 29053.12840614785, 29301.56047659287, 29421.0, 29615.851920740475, 29737.405251895056, 3708.629137086297, 3861.8841434757, 3924.9803750981346, 4035.435039094529, 4084.407760874686, 190451.0, 190789.0, 190859.0, 191163.0, 191409.9999999986, 53428.0, 54396.728016359666, 57808.4219157803, 58077.709611451675, 60137.39862601318, 53920.73039634777, 54001.45998540043, 54113.0, 54163.72918135463, 54172.18741718798, 15795.131267780382, 15796.131212783177, 15826.92086539583, 15852.92073539648, 15957.601059973362, 11073.778524429466, 11112.777744445228, 11131.777364452666, 11138.108951283877, 11169.72075698114, 19156.67265229788, 19609.31367402134, 20364.69452958207, 20374.388768336972, 20408.38774836757, 7338.522996005243, 7339.88990165148, 7369.189389167187, 7418.629068546659, 7568.470207085451, 941.2470023980788, 953.9347313067132, 970.1608108985818, 995.4674249276602, 1010.1363334349172, 27848.582271265946, 28032.0, 28130.859345703142, 28260.0, 28303.15090547287, 1022.1924679503257, 1051.7686109056149, 1073.8281874899978, 1091.901728844408, 1114.2311804854623, 14717.264136793117, 14728.55814325572, 14730.779038314435, 14911.70176596462, 15087.547373578811, 323999.0, 326381.0, 326822.0, 327476.0, 328483.0, 51300.48699513032, 51616.48383516117, 51624.48375516272, 51697.48302516927, 51751.48248517542, 1338.4779935825036, 1345.8721421464945, 1347.1243691600341, 1352.377906163176, 1354.8780609744972, 26253.474930501667, 27445.588316175672, 27616.861915691097, 27832.582511261942, 28020.57969130424, 46238.0, 46418.30372544347, 46540.0, 46795.532044679116, 47049.0, 299409.0, 300429.0, 300612.0, 301000.0, 302688.0, 31802.840985794923, 31970.52044219385, 32191.19522011875, 32390.83804580962, 32545.34909301848, 37750.62249377471, 37827.05432364213, 38500.42249366318, 38759.224815504094, 39232.607673922896, 34568.308633827684, 34858.825705871306, 34958.65041349554, 35311.56974602536, 35691.28617427585, 35041.474377883846, 35437.82281088578, 35498.82250588731, 35885.64114358823, 35917.461238081974, 33856.322873542886, 34462.655373445945, 34966.47550286697, 34991.82504087463, 35191.47212791759, 30794.0, 31539.0, 32076.19809504781, 32246.83876580602, 32335.514967275038, 23181.652275215547, 23403.0, 23423.94592243319, 24253.636195457435, 24671.62992555149], "unit": "score", "name": "ext.html", "value": 18007.056758828392}, {"lowerIsBetter": false, "replicates": [358.97870558261735, 360.79254428703496, 361.167508892004, 362.1525630025739, 364.46423757077093, 14108.15351078936, 14387.928060359709, 16629.667406651875, 16919.577010574725, 17565.912170439147, 14682.192479413628, 14766.409343626268, 14817.703645927075, 14818.0, 14824.407023719064, 5317.813876514323, 5371.221172929922, 5472.370677372113, 5476.151196564539, 5482.616216864821, 5431.592630552705, 5468.0977638689565, 5477.808276710316, 5482.17767334899, 5482.39693633702, 5319.973400132994, 5450.073487507114, 5534.944650553503, 5542.972285138569, 5545.112781954888, 5486.451354864522, 5500.642458240201, 5511.614187006911, 5514.0, 5532.889342213133, 4857.247126695368, 4924.138275801756, 4936.185529387647, 4947.0, 4950.455449900508, 19878.50303742418, 19911.80088199114, 20066.0, 20328.186872525228, 20579.794202057936, 2165.4153378587694, 2199.212222487466, 2306.4579823741406, 2399.3881560202212, 2417.9395515112087, 9304.255659547287, 9425.811483770287, 9447.716568502956, 9570.617175312978, 9664.71005869825, 1792.1129041124727, 1803.0624075480807, 1835.623697142096, 1913.3590247267182, 1979.4556496963307, 58777.0, 60539.394606053815, 61197.0, 61438.385616143714, 61856.69071654613, 10284.331518451278, 10297.639582614573, 10373.533191006423, 10405.06354428105, 10461.84307235392, 11924.821127683092, 12437.813432798515, 12485.812712809315, 13573.321333933263, 13611.455541778416, 7073.186583542855, 7264.019357386791, 7360.411167106618, 7383.114026316876, 7405.851882962311, 6941.479389045841, 6950.374466297956, 6955.478339124586, 6975.686094125675, 7009.859802803915, 4307.483102027777, 4337.479502459725, 4338.067315527177, 4343.326784348431, 4344.978275108604, 1821.653885761701, 1847.6120014797043, 1847.8429333506801, 1889.0649128681391, 1902.7145928110895, 845.3828705045352, 893.8078313162702, 992.4739887859446, 1060.2525219720078, 1089.145021158387, 16820.915895420443, 17158.914205429144, 17259.91370043167, 17284.0, 17787.555311117325, 921.5806807902388, 986.161762501882, 986.6842610364758, 998.2662742883974, 1017.9491025448698, 9683.0, 9883.654072107442, 9908.504574771232, 9934.056264654846, 9961.950190249147, 137216.0, 137748.0, 469960.0, 494288.0, 497933.0, 78704.0, 79292.6035369831, 82633.0, 84416.61548601557, 86321.87240679402, 1124.791913496006, 1160.878107798686, 1176.088531388181, 1176.3177357132843, 1185.4724647531766, 15142.470013549473, 15230.238488075773, 15261.694766104838, 15264.0, 15299.46451874179, 30615.2346191347, 32551.51172732458, 33510.66489335173, 33742.831285843415, 35783.10542236465, 41035.58964410318, 43336.566634333256, 43430.34854477122, 44216.77891610521, 46963.530364695915, 9439.0, 9727.0, 9897.406155630686, 9912.504374781376, 10001.399916005063, 11605.535778568763, 11729.120315976506, 11742.647720568397, 11810.055195584504, 12127.393630318626, 14339.283035848375, 14404.927975360057, 14464.27678616086, 14482.710345793235, 14931.253437327872, 14155.433782648579, 14412.855871441152, 14615.780763288773, 14741.705165896408, 15213.0, 15217.847821522086, 15378.692426151638, 15413.152276624893, 15749.606259843596, 15767.68464630678, 9776.80446391054, 9866.605335786488, 9924.354916930377, 9971.551280192263, 9972.850407243752, 15016.399344026117, 15073.854689960348, 15170.31733572014, 15281.312340944462, 15393.537034074494], "unit": "score", "name": "jquery.html", "value": 8714.697938645106}, {"lowerIsBetter": false, "replicates": [1421.4953691439537, 1458.0668372241764, 1623.3425462687608, 1756.1219390304848, 1794.1029485257363, 6439.130717353168, 6452.354764523545, 7298.854022919545, 7431.033965584466, 7452.478326517146, 7100.57396556207, 7189.173245076805, 7221.4944953853255, 7313.561186328824, 7322.1945585985495, 2222.7777222277805, 2246.6742322363248, 2251.684764133023, 2255.5263394687136, 2260.0507786729613, 2229.2754854672216, 2243.1924507177405, 2317.4669825940045, 2318.5015221727326, 2320.153144102407, 2233.553289342138, 2238.630625946725, 2265.991633722994, 2272.9090836366527, 2295.288460577218, 2224.254874617005, 2227.532218234173, 2277.202978957368, 2280.8631482111127, 2282.018731945271, 2245.158065725353, 2265.32040387883, 2266.2747920665392, 2272.1820144747876, 2276.442271643458, 7324.890126648104, 7332.266773322678, 7391.854262589307, 7418.332350088518, 7422.888656670154, 4509.819607215707, 4609.492955774862, 4616.28447590624, 4629.328747331618, 4632.374629425052, 2983.522636378191, 2994.0718377302887, 3068.248279171617, 3095.721385075354, 3096.0866544369464, 930.7161315798679, 946.9952650236705, 973.3332667123043, 984.807962447323, 995.7411073120968, 10082.0, 10083.546240419199, 10105.090541851196, 10110.090091891692, 10128.240381971382, 4123.0516981093915, 4157.272477316518, 4191.119864828359, 4206.3690446432665, 4210.179015092028, 8633.91366086331, 8677.739667809976, 8687.391882568287, 8693.217610415093, 8710.695125670698, 4620.029793743284, 4639.37368455261, 4663.953360466419, 4693.389859318267, 4693.78877950493, 4134.813933373005, 4170.082581831992, 4224.366345048206, 4236.428082208924, 4243.108947121139, 3378.1048022274117, 3392.8133952632843, 3395.2360718838063, 3400.7789493683326, 3426.3832510147913, 1014.4572653630272, 1024.5491983527224, 1029.1098200057047, 1036.8133735927454, 1047.3244757131608, 1128.351198061118, 1167.5154810753443, 1169.9473523691454, 1204.9457774399998, 1257.5661396818266, 6540.509461790385, 6569.770058048041, 6574.243961944342, 6623.105880706139, 6631.0, 475.8501072162258, 476.4758765358148, 486.29972839111565, 490.364977354327, 490.7374554613265, 5412.864678383072, 5434.538064264581, 5447.591430642638, 5457.126859702428, 5474.124140137559, 8657.696980605648, 8729.60716767747, 8986.19124278818, 9014.18872301483, 9030.36787424874, 8786.384953053224, 8895.4662720237, 8907.242884354773, 8981.730548083437, 8989.41568798026, 6958.373746362851, 7051.0, 7086.078809754699, 7091.113610798753, 7105.75129870452, 6810.28492008332, 6837.589744615339, 6840.281770414035, 6851.45188384918, 6857.314268573103, 7865.882011769713, 8006.83986320282, 8020.679172833022, 8082.434229603871, 8127.2279133482225, 7939.642716077675, 8177.509349438815, 8194.22154895284, 8213.671453141807, 8295.709650162215, 5983.0, 6012.1582978382185, 6369.0, 6534.575252608755, 6546.967265163644, 6984.441244700513, 7080.752173674103, 7083.220845707071, 7100.218975912542, 7117.181524124792, 6531.934680653133, 6575.605463672195, 6822.317768223138, 6823.590584564942, 6869.519133660796, 6395.104685343963, 6448.806970710246, 6453.09656648079, 6521.0, 6549.8690026200165, 6739.898901516383, 6779.15260592426, 6782.559133656297, 6790.354916282945, 6810.9318906810295, 6044.093385992136, 6110.327863935053, 6143.877122457615, 6144.0, 6228.750849965951, 6133.264008318852, 6176.845578860564, 6186.319504854552, 6193.721282542207, 6194.4115309045565], "unit": "score", "name": "mootools.html", "value": 4215.952806052651}, {"lowerIsBetter": false, "replicates": [334.06628473416805, 336.27364891833645, 341.9008487538614, 343.3099470065169, 343.5379414687246, 6259.8122056338325, 6278.152449419333, 6284.245890493142, 6286.559940804145, 6379.808605741823, 6216.564840461169, 6266.561340706153, 6267.43593076623, 6284.654344011077, 6297.496200303976, 4750.097481478517, 4773.069251495942, 4780.0, 4790.7604619769045, 4796.208625576775, 4787.593054590364, 4789.114013907439, 4794.352762377087, 4794.9280760788615, 4795.856124316276, 4653.139169253699, 4743.928841067387, 4746.833860814872, 4750.97624511877, 4756.9286460703115, 4738.620910327183, 4741.431028276612, 4753.930365667732, 4758.690685105492, 4773.880652983668, 4116.403121547389, 4117.649999750025, 4122.91754164918, 4126.112885729583, 4136.110736191733, 5975.043992961106, 5993.9400605993815, 5994.100884867261, 5995.520358371364, 6014.218151640259, 5378.677279363251, 5500.367457742371, 5501.724913754297, 5529.060059789846, 5542.528885044776, 6656.134702488694, 6657.700403481855, 6670.6331151786635, 6685.765998190089, 6686.93313066868, 4551.340055691906, 4571.0, 4584.472785629662, 4592.127495775825, 4597.034622729231, 6772.796816095525, 6881.759138430181, 6947.548409353376, 6953.652317384111, 6965.895511567331, 4655.324977878188, 4673.6728429009645, 4690.624750019991, 4699.624030077585, 4711.976440117777, 4734.171519983989, 4738.597219236334, 4744.169770290186, 4744.667873248839, 4747.287906813936, 5494.835154945358, 5496.835094947158, 5499.285092937893, 5499.780008799683, 5506.834794956158, 6554.279029306773, 6671.299513551105, 6671.964256263389, 6676.766313179015, 6691.397774200345, 1648.8021437427346, 1664.9916750416412, 1692.7884014498188, 1693.898366098038, 1695.271033455626, 1118.0440723181725, 1121.2095472691733, 1126.8366086917351, 1132.9546818127346, 1140.7205234717546, 6299.244090709144, 6302.338254483213, 6310.779122730774, 6311.084892690534, 6319.968400158062, 6806.7957961261245, 6814.454843612499, 6831.385175334244, 6839.110915580943, 6840.452763778886, 6178.382161783786, 6241.781537646251, 6303.653299068504, 6305.621662700252, 6316.684165791692, 3714.0714821294678, 3725.9254814904093, 3726.5341832270965, 3737.4020156774786, 3738.420544815558, 7084.681189346492, 7141.071660684078, 7144.428445724329, 7144.821379465555, 7150.713971441188, 6893.103896493524, 6933.965330173418, 6977.197622273402, 6977.197622273504, 6981.616011119336, 7234.710611575478, 7246.094238220223, 7246.60143692102, 7260.455465840083, 7273.309035641606, 6961.547499412522, 6968.024476573182, 6974.860502790018, 6988.720451182099, 6989.916562932754, 6768.255491895789, 6819.829504262433, 6856.040154378491, 6865.107536020286, 6866.931330686829, 7238.963805180941, 7253.165885923187, 7253.419726421979, 7265.382442492447, 7286.708531658886, 4665.626749859935, 4691.50739172382, 4715.504871988392, 4724.291356296583, 4729.976350118227, 6820.488463365168, 6956.40870526011, 6964.338387853146, 6989.650517474208, 7016.929830701628, 6754.898676519758, 6779.288174741581, 6780.69486873082, 6786.69459874297, 6797.830054248683, 6727.629980351127, 6782.457403407617, 6788.2193547742645, 6788.7284508619105, 6799.796006119825, 6467.191601049869, 6586.967065164644, 6617.43751781104, 6624.503162262946, 6647.966760166169, 6729.629870357177, 6787.864242715217, 6801.2178599461695, 6813.318668133147, 6822.454203663794, 6628.07206991012, 6633.767818126343, 6640.9335906642245, 6642.933570664231, 6645.933540664725], "unit": "score", "name": "prototype.html", "value": 5022.28208763495}, {"lowerIsBetter": false, "replicates": [702.9771682202389, 714.9285071492851, 757.5341165183412, 799.7041094794927, 818.447547905164, 12323.630291091271, 12526.060545459082, 12528.0, 12530.997520198385, 12595.937020314908, 12602.117851750381, 12605.684857878558, 12667.303298318611, 12693.682657933556, 12749.426275817586, 801.6873419366452, 819.1358117186365, 832.3798769916391, 835.3484282259817, 837.4472847920374, 820.5609998650723, 825.3727167352826, 825.7110011495959, 827.2389401750404, 833.6623667414676, 871.2768402226137, 871.5337294547387, 872.5593575244493, 873.76845136039, 874.6326542851986, 859.2867919626757, 864.7838040489909, 865.8701194820795, 866.0257210638032, 867.1848462445345, 639.9072134540512, 640.1645852162926, 640.6444423345042, 641.7721708793358, 643.8969764837603, 13578.185308881499, 13718.65703357424, 13742.312884355842, 13761.793573096411, 13784.724305513833, 11129.610463633733, 11399.886001140048, 11593.478293476814, 11900.404979750978, 12829.42267597951, 10066.29535932485, 10337.74155646115, 10484.266101372907, 10623.521941512574, 10681.626143085032, 3428.9485657715154, 3522.5420695309444, 3566.5185199997927, 3568.1614820517157, 3569.7501174917766, 47133.293000605016, 47484.52515474836, 47670.761646191546, 47714.04571908577, 47838.28242576364, 9556.474393908402, 9653.131218190256, 9893.60425582983, 10402.843957340647, 10988.945055274833, 18650.626987460175, 18729.719054214198, 18774.906125469286, 18789.718154227696, 18846.905765471085, 7463.813404664927, 7468.663910124057, 7601.847963040708, 7642.197569255148, 7802.570858602831, 4274.700770946004, 4346.978265108654, 4420.513743488214, 4423.955760442419, 4517.570830771071, 3140.811551306929, 3143.339898621269, 3151.779375443697, 3157.905262842118, 3170.7304879085073, 557.6876948908624, 559.6949662433983, 562.6005536069355, 566.6260268222953, 570.823044856096, 636.8885445047098, 638.2532437048665, 645.2869579115104, 665.7137430904661, 666.213867636194, 8449.57752112392, 8497.2777313929, 8518.318534517224, 8650.394472386999, 9310.95344523273, 620.1503939602773, 628.5191828251392, 643.4980715042275, 656.5896314803248, 713.162034609332, 3880.476135721698, 3996.980015099906, 4080.714349995472, 4108.958910410917, 4194.30793919006, 55609.44390556124, 60060.39939600635, 60249.69875150596, 60365.396346036854, 60706.69646651827, 52585.47414525882, 52824.20763688471, 53725.731371342896, 54059.18911216335, 54332.0, 47749.76125119421, 47948.7602561985, 48119.75940120347, 48486.0, 49098.263526047136, 7984.441089123938, 8032.638531266224, 8497.957510212409, 8669.30645548342, 9004.81990360176, 32397.676023239466, 32681.509777352883, 32830.17924551905, 34388.0, 34532.48201277033, 44243.11513769771, 48485.63331457384, 48625.75687121542, 48769.756151219015, 48918.0, 10511.369317840954, 10799.40603266828, 11073.822171473705, 11122.165837562054, 11166.49750761234, 11936.641900742992, 12026.879731202576, 12504.562340318045, 12524.749505009666, 12748.0, 10794.460276986276, 10888.401137937173, 11114.777044590952, 11118.388488633203, 11396.772064558829, 10390.844137337795, 10662.786744264917, 10710.946445267724, 10760.677179684622, 10764.623238186627, 10786.514606842555, 10955.397453139834, 11091.778164436828, 11114.333140011626, 11336.659900203007, 9681.08029737202, 9897.35667181631, 9924.206063515046, 9938.204943604349, 10306.742331441774, 9166.770830729285, 9411.858822117536, 9412.294077944045, 9591.28065395112, 9628.32601717873], "unit": "score", "name": "yui.html", "value": 6314.681814789744}], "name": "dromaeo_css", "value": 6913.586491609552}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 111.0, 111.0, 112.0, 123.0, 113.0, 110.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 154.0, 159.0, 129.0, 153.0, 158.0, 128.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.8}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 163.0, 162.0, 161.0, 163.0, 162.0, 170.0, 168.0, 160.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 76.0, 73.0, 73.0, 70.0, 71.0, 144.0, 75.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 145.0, 95.0, 95.0, 96.0, 147.0, 95.0, 102.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 98.0, 97.0, 96.0, 97.0, 97.0, 98.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [62.0, 61.0, 61.0, 59.0, 60.0, 60.0, 60.0, 64.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 59.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 89.0, 88.0, 93.0, 87.0, 94.0, 87.0, 94.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.3}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 115.0, 120.0, 128.0, 119.0, 129.0, 129.0, 120.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [140.0, 156.0, 150.0, 148.0, 156.0, 140.0, 158.0, 148.0, 152.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 72.0, 70.0, 70.0, 67.0, 70.0, 68.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1524.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [197.35543714229328], "unit": "score", "name": "DeltaBlue", "value": 335.019906}, {"lowerIsBetter": false, "replicates": [282.326369282891], "unit": "score", "name": "Encrypt", "value": 942.813102}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1060.3813559322034], "unit": "score", "name": "RayTrace", "value": 697.8517642357643}, {"lowerIsBetter": false, "replicates": [754.1478129713424], "unit": "score", "name": "Earley", "value": 883.7299379999995}, {"lowerIsBetter": false, "replicates": [11904.761904761905], "unit": "score", "name": "Boyer", "value": 55.98289200000003}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [608.272506082725], "unit": "score", "name": "Splay", "value": 133.97120400000006}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21137.743374318226}]} 22:17:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21137.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "6913.59"}}} 22:17:44 INFO - Return code: 0 22:17:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:17:45 INFO - # TBPL SUCCESS # 22:17:45 INFO - Running post-action listener: _resource_record_post_action 22:17:45 INFO - Running post-run listener: _resource_record_post_run 22:17:46 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 28672; Write bytes: 556359680; Read time: 228; Write time: 480324 22:17:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 20480; Write bytes: 235536384; Read time: 208; Write time: 324696 22:17:46 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320823296; Read time: 20; Write time: 155628 22:17:46 INFO - Running post-run listener: _upload_blobber_files 22:17:46 INFO - Blob upload gear active. 22:17:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:17:46 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:17:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:17:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:17:46 INFO - (blobuploader) - INFO - Open directory for files ... 22:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:17:47 INFO - (blobuploader) - INFO - Done attempting. 22:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:17:48 INFO - (blobuploader) - INFO - Done attempting. 22:17:48 INFO - (blobuploader) - INFO - Iteration through files over. 22:17:48 INFO - Return code: 0 22:17:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:17:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:17:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc799d17fc5b4312e9849e1bf104e923a53ff7c22bca1d75ac92de0bbf6ec55197fd5ef03c16f8523bc28ef92a33b1a2551ab1600fab369d1ea2a0435b7758d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b4819fb62987a0b05c59c5d99ffc0f934a797eefb499451073e4c5b5c4de11a704c69b7eedaab35e697109ef84326a1f5fd1a4097b2d4b08e29e8fefcdf4cc6"} 22:17:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:17:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:17:48 INFO - Contents: 22:17:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc799d17fc5b4312e9849e1bf104e923a53ff7c22bca1d75ac92de0bbf6ec55197fd5ef03c16f8523bc28ef92a33b1a2551ab1600fab369d1ea2a0435b7758d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b4819fb62987a0b05c59c5d99ffc0f934a797eefb499451073e4c5b5c4de11a704c69b7eedaab35e697109ef84326a1f5fd1a4097b2d4b08e29e8fefcdf4cc6"} 22:17:48 INFO - Copying logs to upload dir... 22:17:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1282.229194 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-25 22:17:47.973961) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:17:47.977578) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc799d17fc5b4312e9849e1bf104e923a53ff7c22bca1d75ac92de0bbf6ec55197fd5ef03c16f8523bc28ef92a33b1a2551ab1600fab369d1ea2a0435b7758d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b4819fb62987a0b05c59c5d99ffc0f934a797eefb499451073e4c5b5c4de11a704c69b7eedaab35e697109ef84326a1f5fd1a4097b2d4b08e29e8fefcdf4cc6"} build_url:https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/11ZYc9WNTJizY1OSNIjf2g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc799d17fc5b4312e9849e1bf104e923a53ff7c22bca1d75ac92de0bbf6ec55197fd5ef03c16f8523bc28ef92a33b1a2551ab1600fab369d1ea2a0435b7758d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b4819fb62987a0b05c59c5d99ffc0f934a797eefb499451073e4c5b5c4de11a704c69b7eedaab35e697109ef84326a1f5fd1a4097b2d4b08e29e8fefcdf4cc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 22:17:48.002257) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:17:48.002583) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451108976.842991-2008967455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 22:17:48.087327) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:17:48.087647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 22:17:48.087962) ========= ========= Total master_lag: 0.25 =========