builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1451329169.06 results: success (0) buildid: 20151228083050 builduid: 9e78b84f911d4101910fb7b56c723f8e revision: 2005cf2d659683c64139700901fc32ed49c78691 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.055436) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.055927) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.056737) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006464 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.086910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.087220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.144057) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.144362) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.194333) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.194637) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.195027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.195347) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 10:59:29-- 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% 64.7M=0s 2015-12-28 10:59:29 (64.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.388863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.389179) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020328 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.448589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:29.449074) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 2005cf2d659683c64139700901fc32ed49c78691 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 2005cf2d659683c64139700901fc32ed49c78691 --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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 10:59:29,718 truncating revision to first 12 chars 2015-12-28 10:59:29,718 Setting DEBUG logging. 2015-12-28 10:59:29,718 attempt 1/10 2015-12-28 10:59:29,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/2005cf2d6596?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 10:59:30,124 unpacking tar archive at: b2g-inbound-2005cf2d6596/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684680 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:30.148128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:30.148462) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:30.158765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:30.159187) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 10:59:30.159893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-28 10:59:30.160335) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:59:30 INFO - MultiFileLogger online at 20151228 10:59:30 in /builds/slave/test-pgo 10:59:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:59:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:59:30 INFO - {'append_to_log': False, 10:59:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:59:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:59:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:59:30 INFO - 'branch': 'B2G-Inbound', 10:59:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:30 INFO - 'config_files': ('talos/linux_config.py',), 10:59:30 INFO - 'default_actions': ('clobber', 10:59:30 INFO - 'read-buildbot-config', 10:59:30 INFO - 'download-and-extract', 10:59:30 INFO - 'populate-webroot', 10:59:30 INFO - 'create-virtualenv', 10:59:30 INFO - 'install', 10:59:30 INFO - 'run-tests'), 10:59:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:30 INFO - 'download_minidump_stackwalk': True, 10:59:30 INFO - 'download_symbols': 'ondemand', 10:59:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:30 INFO - 'installer_path': 'installer.exe', 10:59:30 INFO - 'log_level': 'info', 10:59:30 INFO - 'log_name': 'talos', 10:59:30 INFO - 'log_to_console': True, 10:59:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:59:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:59:30 INFO - 'opt_config_files': (), 10:59:30 INFO - 'pip_index': False, 10:59:30 INFO - 'sps_profile': False, 10:59:30 INFO - 'sps_profile_interval': 0, 10:59:30 INFO - 'suite': 'dromaeojs', 10:59:30 INFO - 'system_bits': '32', 10:59:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:30 INFO - 'title': 'talos-linux64-ix-046', 10:59:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:30 INFO - 'use_talos_json': True, 10:59:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:59:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:30 INFO - 'work_dir': 'build'} 10:59:30 INFO - ##### 10:59:30 INFO - ##### Running clobber step. 10:59:30 INFO - ##### 10:59:30 INFO - Running pre-action listener: _resource_record_pre_action 10:59:30 INFO - Running main action method: clobber 10:59:30 INFO - rmtree: /builds/slave/test-pgo/build 10:59:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:59:30 INFO - Running post-action listener: _resource_record_post_action 10:59:30 INFO - ##### 10:59:30 INFO - ##### Running read-buildbot-config step. 10:59:30 INFO - ##### 10:59:30 INFO - Running pre-action listener: _resource_record_pre_action 10:59:30 INFO - Running main action method: read_buildbot_config 10:59:30 INFO - Using buildbot properties: 10:59:30 INFO - { 10:59:30 INFO - "project": "", 10:59:30 INFO - "product": "firefox", 10:59:30 INFO - "script_repo_revision": "production", 10:59:30 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:59:30 INFO - "repository": "", 10:59:30 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:59:30 INFO - "buildid": "20151228083050", 10:59:30 INFO - "pgo_build": "True", 10:59:30 INFO - "basedir": "/builds/slave/test-pgo", 10:59:30 INFO - "buildnumber": 159, 10:59:30 INFO - "slavename": "talos-linux64-ix-046", 10:59:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:59:30 INFO - "platform": "ubuntu64_hw", 10:59:30 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:59:30 INFO - "branch": "b2g-inbound", 10:59:30 INFO - "repo_path": "integration/b2g-inbound", 10:59:30 INFO - "revision": "2005cf2d659683c64139700901fc32ed49c78691", 10:59:30 INFO - "stage_platform": "linux64-pgo", 10:59:30 INFO - "builduid": "9e78b84f911d4101910fb7b56c723f8e", 10:59:30 INFO - "slavebuilddir": "test" 10:59:30 INFO - } 10:59:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:59:30 INFO - Running post-action listener: _resource_record_post_action 10:59:30 INFO - ##### 10:59:30 INFO - ##### Running download-and-extract step. 10:59:30 INFO - ##### 10:59:30 INFO - Running pre-action listener: _resource_record_pre_action 10:59:30 INFO - Running main action method: download_and_extract 10:59:30 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:30 INFO - https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/test_packages.json 10:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/test_packages.json 10:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:59:32 INFO - Downloaded 1302 bytes. 10:59:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:59:32 INFO - Using the following test package requirements: 10:59:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:59:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'jsshell-linux-x86_64.zip'], 10:59:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:59:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:59:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:59:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:59:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:59:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:59:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:59:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:59:32 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')]} 10:59:32 INFO - https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:33 INFO - Downloaded 23191198 bytes. 10:59:33 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 10:59:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:33 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 10:59:34 INFO - Return code: 0 10:59:34 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 10:59: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')]} 10:59:34 INFO - https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:59:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:37 INFO - Downloaded 23191198 bytes. 10:59:37 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 10:59:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:59:37 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 10:59:38 INFO - Return code: 0 10:59: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')]} 10:59:38 INFO - https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:59:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:39 INFO - Downloaded 11132270 bytes. 10:59:39 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 10:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:59:39 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 10:59:40 INFO - Return code: 0 10:59:40 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')]} 10:59:40 INFO - https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N1rsQH7GQX2Gp9EffQSacw/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 10:59:42 INFO - Downloaded 54888017 bytes. 10:59:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:42 INFO - mkdir: /builds/slave/test-pgo/properties 10:59:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:59:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:59:42 INFO - Contents: 10:59:42 INFO - build_url:https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:59:42 INFO - Running post-action listener: _resource_record_post_action 10:59:42 INFO - Running post-action listener: set_extra_try_arguments 10:59:42 INFO - ##### 10:59:42 INFO - ##### Running populate-webroot step. 10:59:42 INFO - ##### 10:59:42 INFO - Running pre-action listener: _resource_record_pre_action 10:59:42 INFO - Running main action method: populate_webroot 10:59:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:59:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:59:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:59:42 INFO - '--tppagecycles', 10:59:42 INFO - '7'], 10:59:42 INFO - 'tests': ['tsvgm']}}, 10:59:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:59:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:59:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:59:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'tests': ['damp', 'tps']}, 10:59:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['damp', 'tps']}, 10:59:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:59:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:42 INFO - 'other': {'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'other_l64': {'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'other_nol64': {'tests': ['a11yr', 10:59:42 INFO - 'ts_paint', 10:59:42 INFO - 'tpaint', 10:59:42 INFO - 'sessionrestore', 10:59:42 INFO - 'sessionrestore_no_auto_restore']}, 10:59:42 INFO - 'svgr': {'tests': ['tsvgx', 10:59:42 INFO - 'tsvgr_opacity', 10:59:42 INFO - 'tart', 10:59:42 INFO - 'tscrollx', 10:59:42 INFO - 'cart']}, 10:59:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['tsvgx', 10:59:42 INFO - 'tsvgr_opacity', 10:59:42 INFO - 'tart', 10:59:42 INFO - 'tscrollx', 10:59:42 INFO - 'cart']}, 10:59:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'tests': ['tp5o']}, 10:59:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'talos_options': ['--e10s'], 10:59:42 INFO - 'tests': ['tp5o']}, 10:59:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'talos_options': ['--xperf_path', 10:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:42 INFO - 'tests': ['tp5n']}, 10:59:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:59:42 INFO - 'talos_options': ['--e10s', 10:59:42 INFO - '--xperf_path', 10:59:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:42 INFO - 'tests': ['tp5n']}}, 10:59:42 INFO - 'talos.zip': {'path': '', 10:59:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:59:42 INFO - Running post-action listener: _resource_record_post_action 10:59:42 INFO - ##### 10:59:42 INFO - ##### Running create-virtualenv step. 10:59:42 INFO - ##### 10:59:42 INFO - Running pre-action listener: _resource_record_pre_action 10:59:42 INFO - Running main action method: create_virtualenv 10:59:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:59:42 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 10:59:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:59:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:42 INFO - Using real prefix '/usr' 10:59:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:59:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:44 INFO - Installing pip.................done. 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:59:44 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')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:44 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 10:59:44 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 10:59:44 INFO - Using env: {'DISPLAY': ':0', 10:59:44 INFO - 'HOME': '/home/cltbld', 10:59:44 INFO - 'LANG': 'en_US.UTF-8', 10:59:44 INFO - 'LANGUAGE': 'en_US:en', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MAIL': '/var/mail/cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SHLVL': '1', 10:59:44 INFO - 'TERM': 'linux', 10:59:44 INFO - 'TMOUT': '86400', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - '_': '/tools/buildbot/bin/python'} 10:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:44 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 10:59:44 INFO - Cleaning up... 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:59:44 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')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:44 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:44 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 10:59:44 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 10:59:44 INFO - Using env: {'DISPLAY': ':0', 10:59:44 INFO - 'HOME': '/home/cltbld', 10:59:44 INFO - 'LANG': 'en_US.UTF-8', 10:59:44 INFO - 'LANGUAGE': 'en_US:en', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MAIL': '/var/mail/cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SHLVL': '1', 10:59:44 INFO - 'TERM': 'linux', 10:59:44 INFO - 'TMOUT': '86400', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - '_': '/tools/buildbot/bin/python'} 10:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:45 INFO - Downloading/unpacking psutil>=0.7.1 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:45 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 10:59:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:59:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:46 INFO - Installing collected packages: psutil 10:59:46 INFO - Running setup.py install for psutil 10:59:46 INFO - building 'psutil._psutil_linux' extension 10:59:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:59:47 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 10:59:47 INFO - building 'psutil._psutil_posix' extension 10:59:47 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 10:59:47 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 10:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:47 INFO - Successfully installed psutil 10:59:47 INFO - Cleaning up... 10:59:47 INFO - Return code: 0 10:59:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:59:47 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')]} 10:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:47 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')]} 10:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:47 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:47 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 10:59:47 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 10:59:47 INFO - Using env: {'DISPLAY': ':0', 10:59:47 INFO - 'HOME': '/home/cltbld', 10:59:47 INFO - 'LANG': 'en_US.UTF-8', 10:59:47 INFO - 'LANGUAGE': 'en_US:en', 10:59:47 INFO - 'LOGNAME': 'cltbld', 10:59:47 INFO - 'MAIL': '/var/mail/cltbld', 10:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:47 INFO - 'MOZ_NO_REMOTE': '1', 10:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:47 INFO - 'NO_EM_RESTART': '1', 10:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:47 INFO - 'SHELL': '/bin/bash', 10:59:47 INFO - 'SHLVL': '1', 10:59:47 INFO - 'TERM': 'linux', 10:59:47 INFO - 'TMOUT': '86400', 10:59:47 INFO - 'USER': 'cltbld', 10:59:47 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:47 INFO - '_': '/tools/buildbot/bin/python'} 10:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:59:47 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 10:59:47 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 10:59:47 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 10:59:47 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 10:59:47 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 10:59:47 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 10:59:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:59:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:59:49 INFO - Installing collected packages: mozsystemmonitor 10:59:49 INFO - Running setup.py install for mozsystemmonitor 10:59:49 INFO - Successfully installed mozsystemmonitor 10:59:49 INFO - Cleaning up... 10:59:49 INFO - Return code: 0 10:59:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:59: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')]} 10:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:49 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:49 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 10:59:49 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 10:59:49 INFO - Using env: {'DISPLAY': ':0', 10:59:49 INFO - 'HOME': '/home/cltbld', 10:59:49 INFO - 'LANG': 'en_US.UTF-8', 10:59:49 INFO - 'LANGUAGE': 'en_US:en', 10:59:49 INFO - 'LOGNAME': 'cltbld', 10:59:49 INFO - 'MAIL': '/var/mail/cltbld', 10:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:49 INFO - 'MOZ_NO_REMOTE': '1', 10:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:49 INFO - 'NO_EM_RESTART': '1', 10:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:49 INFO - 'SHELL': '/bin/bash', 10:59:49 INFO - 'SHLVL': '1', 10:59:49 INFO - 'TERM': 'linux', 10:59:49 INFO - 'TMOUT': '86400', 10:59:49 INFO - 'USER': 'cltbld', 10:59:49 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:49 INFO - '_': '/tools/buildbot/bin/python'} 10:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:49 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:49 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 10:59:49 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 10:59:49 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 10:59:49 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 10:59:49 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 10:59:49 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 10:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:59:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:52 INFO - Downloading docopt-0.6.1.tar.gz 10:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:59:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:52 INFO - Running setup.py install for blobuploader 10:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:59:52 INFO - Running setup.py install for requests 10:59:52 INFO - Running setup.py install for docopt 10:59:52 INFO - Successfully installed blobuploader requests docopt 10:59:52 INFO - Cleaning up... 10:59:52 INFO - Return code: 0 10:59:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:59: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')]} 10:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:52 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 10:59:52 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 10:59:52 INFO - Using env: {'DISPLAY': ':0', 10:59:52 INFO - 'HOME': '/home/cltbld', 10:59:52 INFO - 'LANG': 'en_US.UTF-8', 10:59:52 INFO - 'LANGUAGE': 'en_US:en', 10:59:52 INFO - 'LOGNAME': 'cltbld', 10:59:52 INFO - 'MAIL': '/var/mail/cltbld', 10:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:52 INFO - 'MOZ_NO_REMOTE': '1', 10:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:52 INFO - 'NO_EM_RESTART': '1', 10:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:52 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:52 INFO - 'SHELL': '/bin/bash', 10:59:52 INFO - 'SHLVL': '1', 10:59:52 INFO - 'TERM': 'linux', 10:59:52 INFO - 'TMOUT': '86400', 10:59:52 INFO - 'USER': 'cltbld', 10:59:52 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:52 INFO - '_': '/tools/buildbot/bin/python'} 10:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:52 INFO - Running setup.py (path:/tmp/pip-3E54YW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:53 INFO - Running setup.py (path:/tmp/pip-NxoQI9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:53 INFO - Running setup.py (path:/tmp/pip-XKrpQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:53 INFO - Running setup.py (path:/tmp/pip-GTVyxb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:53 INFO - Running setup.py (path:/tmp/pip-IS1Sbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:53 INFO - Running setup.py (path:/tmp/pip-tbIZux-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:53 INFO - Running setup.py (path:/tmp/pip-r9FVGJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:53 INFO - Running setup.py (path:/tmp/pip-vu3_DH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:53 INFO - Running setup.py (path:/tmp/pip-t9Lwjn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:53 INFO - Running setup.py (path:/tmp/pip-tBwWMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:53 INFO - Running setup.py (path:/tmp/pip-JUpWKk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:53 INFO - Running setup.py (path:/tmp/pip-Gw_ZhJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:53 INFO - Running setup.py (path:/tmp/pip-0Qr2Mc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:53 INFO - Running setup.py (path:/tmp/pip-QWUg7y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:53 INFO - Running setup.py (path:/tmp/pip-ECV80o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:54 INFO - Running setup.py (path:/tmp/pip-S_q_iP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:54 INFO - Running setup.py (path:/tmp/pip-jeFBNl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:54 INFO - Running setup.py install for manifestparser 10:59:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Running setup.py install for mozcrash 10:59:54 INFO - Running setup.py install for mozdebug 10:59:54 INFO - Running setup.py install for mozdevice 10:59:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Running setup.py install for mozfile 10:59:54 INFO - Running setup.py install for mozhttpd 10:59:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Running setup.py install for mozinfo 10:59:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Running setup.py install for mozInstall 10:59:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:59:54 INFO - Running setup.py install for mozleak 10:59:55 INFO - Running setup.py install for mozlog 10:59:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Running setup.py install for moznetwork 10:59:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Running setup.py install for mozprocess 10:59:55 INFO - Running setup.py install for mozprofile 10:59:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Running setup.py install for mozrunner 10:59:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Running setup.py install for mozscreenshot 10:59:55 INFO - Running setup.py install for moztest 10:59:55 INFO - Running setup.py install for mozversion 10:59:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:59:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:55 INFO - Cleaning up... 10:59:55 INFO - Return code: 0 10:59:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:55 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:55 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 10:59:55 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 10:59:55 INFO - Using env: {'DISPLAY': ':0', 10:59:55 INFO - 'HOME': '/home/cltbld', 10:59:55 INFO - 'LANG': 'en_US.UTF-8', 10:59:55 INFO - 'LANGUAGE': 'en_US:en', 10:59:55 INFO - 'LOGNAME': 'cltbld', 10:59:55 INFO - 'MAIL': '/var/mail/cltbld', 10:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:55 INFO - 'MOZ_NO_REMOTE': '1', 10:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:55 INFO - 'NO_EM_RESTART': '1', 10:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:55 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:55 INFO - 'SHELL': '/bin/bash', 10:59:55 INFO - 'SHLVL': '1', 10:59:55 INFO - 'TERM': 'linux', 10:59:55 INFO - 'TMOUT': '86400', 10:59:55 INFO - 'USER': 'cltbld', 10:59:55 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:55 INFO - '_': '/tools/buildbot/bin/python'} 10:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:56 INFO - Running setup.py (path:/tmp/pip-rStUsI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:56 INFO - Running setup.py (path:/tmp/pip-Y1xkkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:56 INFO - Running setup.py (path:/tmp/pip-bBX4fB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:56 INFO - Running setup.py (path:/tmp/pip-tAf4QE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:56 INFO - Running setup.py (path:/tmp/pip-zwQUCD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:56 INFO - Running setup.py (path:/tmp/pip-08Tp3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:56 INFO - Running setup.py (path:/tmp/pip-vmQOjQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:59:56 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)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:56 INFO - Running setup.py (path:/tmp/pip-iWtjPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:56 INFO - Running setup.py (path:/tmp/pip-2FZPtR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:56 INFO - Running setup.py (path:/tmp/pip-ZB84yO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:56 INFO - Running setup.py (path:/tmp/pip-Cmzq1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:59:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:59:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:56 INFO - Running setup.py (path:/tmp/pip-4Xge1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:59:57 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)) 10:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:57 INFO - Running setup.py (path:/tmp/pip-Nzhuh0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:59:57 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)) 10:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:57 INFO - Running setup.py (path:/tmp/pip-dcbAGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:59:57 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)) 10:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:57 INFO - Running setup.py (path:/tmp/pip-kYX4aC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:59:57 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)) 10:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:57 INFO - Running setup.py (path:/tmp/pip-9ar_yZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:59:57 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)) 10:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:57 INFO - Running setup.py (path:/tmp/pip-U84k8o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:59:57 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)) 10:59:57 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)) 10:59:57 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)) 10:59:57 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)) 10:59:57 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)) 10:59:57 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)) 10:59:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:59 INFO - Downloading blessings-1.5.1.tar.gz 10:59:59 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 10:59:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:59 INFO - Installing collected packages: blessings 10:59:59 INFO - Running setup.py install for blessings 10:59:59 INFO - Successfully installed blessings 10:59:59 INFO - Cleaning up... 10:59:59 INFO - Return code: 0 10:59:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:59:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:59:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:59:59 INFO - Reading from file tmpfile_stdout 10:59:59 INFO - Current package versions: 10:59:59 INFO - argparse == 1.2.1 10:59:59 INFO - blessings == 1.5.1 10:59:59 INFO - blobuploader == 1.2.4 10:59:59 INFO - docopt == 0.6.1 10:59:59 INFO - manifestparser == 1.1 10:59:59 INFO - mozInstall == 1.12 10:59:59 INFO - mozcrash == 0.16 10:59:59 INFO - mozdebug == 0.1 10:59:59 INFO - mozdevice == 0.47 10:59:59 INFO - mozfile == 1.2 10:59:59 INFO - mozhttpd == 0.7 10:59:59 INFO - mozinfo == 0.9 10:59:59 INFO - mozleak == 0.1 10:59:59 INFO - mozlog == 3.1 10:59:59 INFO - moznetwork == 0.27 10:59:59 INFO - mozprocess == 0.22 10:59:59 INFO - mozprofile == 0.28 10:59:59 INFO - mozrunner == 6.11 10:59:59 INFO - mozscreenshot == 0.1 10:59:59 INFO - mozsystemmonitor == 0.0 10:59:59 INFO - moztest == 0.7 10:59:59 INFO - mozversion == 1.4 10:59:59 INFO - psutil == 3.1.1 10:59:59 INFO - requests == 1.2.3 10:59:59 INFO - wsgiref == 0.1.2 10:59:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:59 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:59 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 10:59:59 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 10:59:59 INFO - Using env: {'DISPLAY': ':0', 10:59:59 INFO - 'HOME': '/home/cltbld', 10:59:59 INFO - 'LANG': 'en_US.UTF-8', 10:59:59 INFO - 'LANGUAGE': 'en_US:en', 10:59:59 INFO - 'LOGNAME': 'cltbld', 10:59:59 INFO - 'MAIL': '/var/mail/cltbld', 10:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:59 INFO - 'MOZ_NO_REMOTE': '1', 10:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:59 INFO - 'NO_EM_RESTART': '1', 10:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:59 INFO - 'SHELL': '/bin/bash', 10:59:59 INFO - 'SHLVL': '1', 10:59:59 INFO - 'TERM': 'linux', 10:59:59 INFO - 'TMOUT': '86400', 10:59:59 INFO - 'USER': 'cltbld', 10:59:59 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:59 INFO - '_': '/tools/buildbot/bin/python'} 10:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 10:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 10:59:59 INFO - Cleaning up... 10:59:59 INFO - Return code: 0 10:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:59 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 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 10:59:59 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 10:59:59 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 10:59:59 INFO - Using env: {'DISPLAY': ':0', 10:59:59 INFO - 'HOME': '/home/cltbld', 10:59:59 INFO - 'LANG': 'en_US.UTF-8', 10:59:59 INFO - 'LANGUAGE': 'en_US:en', 10:59:59 INFO - 'LOGNAME': 'cltbld', 10:59:59 INFO - 'MAIL': '/var/mail/cltbld', 10:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:59 INFO - 'MOZ_NO_REMOTE': '1', 10:59:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:59 INFO - 'NO_EM_RESTART': '1', 10:59:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:59:59 INFO - 'PWD': '/builds/slave/test-pgo', 10:59:59 INFO - 'SHELL': '/bin/bash', 10:59:59 INFO - 'SHLVL': '1', 10:59:59 INFO - 'TERM': 'linux', 10:59:59 INFO - 'TMOUT': '86400', 10:59:59 INFO - 'USER': 'cltbld', 10:59:59 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 10:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:59 INFO - '_': '/tools/buildbot/bin/python'} 10:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:59 INFO - Downloading/unpacking jsonschema 10:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:01 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 11:00:01 INFO - Downloading/unpacking functools32 (from jsonschema) 11:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:00:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:01 INFO - warning: no files found matching '*.txt' 11:00:01 INFO - no previously-included directories found matching 'build' 11:00:01 INFO - no previously-included directories found matching 'dist' 11:00:01 INFO - no previously-included directories found matching '.git*' 11:00:01 INFO - Installing collected packages: jsonschema, functools32 11:00:01 INFO - Running setup.py install for functools32 11:00:02 INFO - warning: no files found matching '*.txt' 11:00:02 INFO - no previously-included directories found matching 'build' 11:00:02 INFO - no previously-included directories found matching 'dist' 11:00:02 INFO - no previously-included directories found matching '.git*' 11:00:02 INFO - Successfully installed jsonschema functools32 11:00:02 INFO - Cleaning up... 11:00:02 INFO - Return code: 0 11:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:00: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')]} 11:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94e20acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, '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': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', '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 11:00: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', 'flake8'] in /builds/slave/test-pgo/build 11:00: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 flake8 11:00:02 INFO - Using env: {'DISPLAY': ':0', 11:00:02 INFO - 'HOME': '/home/cltbld', 11:00:02 INFO - 'LANG': 'en_US.UTF-8', 11:00:02 INFO - 'LANGUAGE': 'en_US:en', 11:00:02 INFO - 'LOGNAME': 'cltbld', 11:00:02 INFO - 'MAIL': '/var/mail/cltbld', 11:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:02 INFO - 'MOZ_NO_REMOTE': '1', 11:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:02 INFO - 'NO_EM_RESTART': '1', 11:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:02 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:02 INFO - 'SHELL': '/bin/bash', 11:00:02 INFO - 'SHLVL': '1', 11:00:02 INFO - 'TERM': 'linux', 11:00:02 INFO - 'TMOUT': '86400', 11:00:02 INFO - 'USER': 'cltbld', 11:00:02 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 11:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:02 INFO - '_': '/tools/buildbot/bin/python'} 11:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:02 INFO - Downloading/unpacking flake8 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:00:04 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 11:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:00:04 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 11:00:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:04 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 11:00:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:00:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:05 INFO - no previously-included directories found matching 'docs/_build' 11:00:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:00:05 INFO - Running setup.py install for pep8 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:05 INFO - no previously-included directories found matching 'docs/_build' 11:00:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:00:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:00:05 INFO - Cleaning up... 11:00:05 INFO - Return code: 0 11:00:05 INFO - Running post-action listener: _resource_record_post_action 11:00:05 INFO - Running post-action listener: _start_resource_monitoring 11:00:05 INFO - Starting resource monitoring. 11:00:05 INFO - ##### 11:00:05 INFO - ##### Running install step. 11:00:05 INFO - ##### 11:00:05 INFO - Running pre-action listener: _resource_record_pre_action 11:00:05 INFO - Running main action method: install 11:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:00:05 INFO - Reading from file tmpfile_stdout 11:00:05 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:00:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:00:05 INFO - Reading from file tmpfile_stdout 11:00:05 INFO - Output received: 11:00:05 INFO - Usage: mozinstall [options] installer 11:00:05 INFO - Options: 11:00:05 INFO - -h, --help show this help message and exit 11:00:05 INFO - -d DEST, --destination=DEST 11:00:05 INFO - Directory to install application into. [default: 11:00:05 INFO - "/builds/slave/test-pgo"] 11:00:05 INFO - --app=APP Application being installed. [default: firefox] 11:00:05 INFO - mkdir: /builds/slave/test-pgo/build/application 11:00:05 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'] 11:00:05 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 11:00:21 INFO - Reading from file tmpfile_stdout 11:00:21 INFO - Output received: 11:00:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:00:21 INFO - Running post-action listener: _resource_record_post_action 11:00:21 INFO - ##### 11:00:21 INFO - ##### Running run-tests step. 11:00:21 INFO - ##### 11:00:21 INFO - Running pre-action listener: _resource_record_pre_action 11:00:21 INFO - Running main action method: run_tests 11:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:00:21 INFO - Python 2.7.3 11:00:21 INFO - Return code: 0 11:00:21 INFO - grabbing minidump binary from tooltool 11:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:21 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 0x2153840>, '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 0x20c06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20c0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:00:21 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 11:00:21 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 11:00:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:21 INFO - Return code: 0 11:00:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:00:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:00:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:00:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:00:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:00:22 INFO - Return code: 0 11:00:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 11:00:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 11:00:22 INFO - Using env: {'DISPLAY': ':0', 11:00:22 INFO - 'HOME': '/home/cltbld', 11:00:22 INFO - 'LANG': 'en_US.UTF-8', 11:00:22 INFO - 'LANGUAGE': 'en_US:en', 11:00:22 INFO - 'LOGNAME': 'cltbld', 11:00:22 INFO - 'MAIL': '/var/mail/cltbld', 11:00:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:00:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:22 INFO - 'MOZ_NO_REMOTE': '1', 11:00:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:22 INFO - 'NO_EM_RESTART': '1', 11:00:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:00:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:00:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:00:22 INFO - 'SHELL': '/bin/bash', 11:00:22 INFO - 'SHLVL': '1', 11:00:22 INFO - 'TERM': 'linux', 11:00:22 INFO - 'TMOUT': '86400', 11:00:22 INFO - 'USER': 'cltbld', 11:00:22 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446', 11:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:22 INFO - '_': '/tools/buildbot/bin/python'} 11:00:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:00:22 INFO - mozversion application_buildid: 20151228083050 11:00:22 INFO - mozversion application_changeset: 2005cf2d659683c64139700901fc32ed49c78691 11:00:22 INFO - mozversion application_display_name: Nightly 11:00:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:22 INFO - mozversion application_name: Firefox 11:00:22 INFO - mozversion application_remotingname: firefox 11:00:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 11:00:22 INFO - mozversion application_vendor: Mozilla 11:00:22 INFO - mozversion application_version: 46.0a1 11:00:22 INFO - mozversion platform_buildid: 20151228083050 11:00:22 INFO - mozversion platform_changeset: 2005cf2d659683c64139700901fc32ed49c78691 11:00:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 11:00:22 INFO - mozversion platform_version: 46.0a1 11:00:22 INFO - using testdate: 1451329222 11:00:22 INFO - actual date: 1451329222 11:00:22 INFO - starting webserver on 'localhost:52717' 11:00:22 INFO - SUITE-START | Running 3 tests 11:00:22 INFO - TEST-START | dromaeo_css 11:00:22 INFO - operating with platform_type : linux_ 11:00:22 INFO - Initialising browser for dromaeo_css test... 11:00:22 INFO - TEST-INFO | started process 3775 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbhA290/profile http://localhost:52717/getInfo.html) 11:00:26 INFO - PROCESS | 3775 | __metrics Screen width/height:1600/1200 11:00:26 INFO - PROCESS | 3775 | colorDepth:24 11:00:26 INFO - PROCESS | 3775 | Browser inner width/height: 1024/697 11:00:26 INFO - PROCESS | 3775 | __metrics 11:00:27 INFO - PROCESS | 3775 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:00:27 INFO - PROCESS | 3775 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:00:27 INFO - TEST-INFO | 3775: exit 0 11:00:27 INFO - Browser initialized. 11:00:27 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:27 INFO - TEST-INFO | started process 3868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbhA290/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:39 INFO - PROCESS | 3868 | RSS: Main: 149057536 11:00:39 INFO - PROCESS | 3868 | 11:01:31 INFO - PROCESS | 3868 | 1451329291190 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] 11:03:39 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52717/tests/dromaeo/cssquery-ext.html) 11:03:40 INFO - PROCESS | 3868 | RSS: Main: 269017088 11:03:40 INFO - PROCESS | 3868 | 11:06:42 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-ext.html (next: http://localhost:52717/tests/dromaeo/cssquery-jquery.html) 11:06:43 INFO - PROCESS | 3868 | RSS: Main: 229388288 11:06:43 INFO - PROCESS | 3868 | 11:09:45 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52717/tests/dromaeo/cssquery-mootools.html) 11:09:45 INFO - PROCESS | 3868 | RSS: Main: 230281216 11:09:45 INFO - PROCESS | 3868 | 11:12:47 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52717/tests/dromaeo/cssquery-prototype.html) 11:12:48 INFO - PROCESS | 3868 | RSS: Main: 210997248 11:12:48 INFO - PROCESS | 3868 | 11:15:50 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52717/tests/dromaeo/cssquery-yui.html) 11:15:51 INFO - PROCESS | 3868 | RSS: Main: 214552576 11:15:51 INFO - PROCESS | 3868 | 11:18:53 INFO - PROCESS | 3868 | Cycle 1(1): loaded http://localhost:52717/tests/dromaeo/cssquery-yui.html (next: http://localhost:52717/tests/dromaeo/cssquery-dojo.html) 11:18:54 INFO - PROCESS | 3868 | RSS: Main: 272408576 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | __start_tp_report 11:18:54 INFO - PROCESS | 3868 | _x_x_mozilla_page_load 11:18:54 INFO - PROCESS | 3868 | _x_x_mozilla_page_load_details 11:18:54 INFO - PROCESS | 3868 | |i|pagename|runs| 11:18:54 INFO - PROCESS | 3868 | |0;dojo.html;3074.308280636856;3108.549260357247;3149.59055322808;3156.9052928412143;3172.7937684050535;5037.1688671369275;5118.718470484127;5128.820491282801;5151.459096794834;5154.355705536808;5142.974285128578;5153.4846515348445;5166.819161329354;5169.638125331228;5205.349331333583;4655.790489427967;4724.338592597039;4745.59662428694;4758.143534163849;4790.377250957371;4684.578387945085;4818.951810481903;4833;4840.080384726908;4847.2002119650215;4664.253719404879;4717.268823332389;4740.834070807539;4777.737224452654;4843.564079232869;4623.491415944277;4697;4725.267583524559;4735.928961065587;4761.6904901181315;4680.531946805327;4684.484706682262;4689.906201875978;4695.788689508946;4711.599514041311;4924.901501969976;4962.87592810179;4982;5017.422996355393;5041.067402530543;5463.2078348639625;5513.751881165357;5517.917231241535;5523.6409633374105;5542.8337149885565;5566.387697353288;5590.580706447033;5592.273004509388;5595.832125036255;5595.8880822383735;5151.5621172200035;5190.455002224788;5218.321618189611;5229.738513074331;5251.68489890604;5694.800681976111;5696.259486266758;5716.28546431696;5721.742521586539;5748.425157484218;5490;5499.780008799603;5500.367457742331;5502.697351645618;5551.861203469864;5422.43064478232;5515.641483303572;5580.525655319343;5598.86002849932;5603.467670571289;5515;5598.10430331145;5599.188117722907;5604.85987850307;5646.802361917313;5493.450654934474;5494.313210848644;5497.285352904097;5499.202615620713;5499.50504454601;4203.91592168155;4274.358846173099;4281.422008028939;4291.420658211164;4293.334533147367;3876.1278712290073;3887.902802429962;3892.3966785148345;3905.5899130591447;3919;5192.688438693691;5208.5312321891215;5228.085085110167;5230.764615592308;5276.208568714724;5394.91907621386;5488.890222195534;5493.395726470085;5499.560035197174;5593.916091258634;5229.137192363293;5244.763985620656;5249;5252.973735131376;5255.132903071027;4821.710697358169;4842.782074806642;4847.587955023792;4853.6602437829015;4889.046635905964;5567.693776842231;5695.572832037614;5726.112452569859;5754;5840.912386314294;5573.749181286933;5585.1901474286815;5588.41321661236;5591.804286849941;5600.103983362643;5738.713064346849;5748.798792042258;5750.712464376848;5756.079027355603;5756.71216439168;5367.329083864517;5452.182172673972;5459.2629994950175;5469.808556700496;5576.888462230814;5605.607607467438;5607.467290607386;5608.719564021864;5609.971950140223;5610.7194640268635;5406.648567843077;5427.918581221206;5479.643823151642;5481.588880833874;5519.254900588529;5300.416954135119;5383.7846486140115;5413.675179489243;5438.891222175614;5479.479449452296;5287.365516138088;5293;5297.125974214211;5297.761600727899;5299.125644268653;5322.654027488201;5380.085385484555;5386.59600529954;5438.374586922555;5444.1017232156255;5299;5311.548518375981;5345.957538279998;5379.031774280511;5418.756155972912 11:18:54 INFO - PROCESS | 3868 | |1;ext.html;557.3172863242528;600.2167171840747;607.6263098194609;622.9781957631484;624.3226099681845;27925.301867453298;28572;28606.57090143647;28634.856825715895;35602;38212.617873821255;38668.61331386685;38888.61111388885;39026.21947561047;39062;8430.536320502386;8604.053554109074;8619.870701939475;8625.827483450326;8626.309895208367;7550.093988721361;7630.694772209105;7641.923580764204;8350.415470917038;10013.499325033756;9863.112319891208;9865.358751681153;9912.207023438108;9946.65186718465;9947.950260248688;9858.556364963593;9959.502024898798;9981.351212171186;9983.550740216635;9986;7529.322360987483;7664.961675191644;7672;9970;10209.591616335338;35073.1231719209;35392.11519712002;35399.82300088509;35401.64598354035;35431.645683543094;3128.671489493593;3298.620658624241;3822.10180607557;3861.8841434757;3902.1025164212106;27946.720532794818;28108.578371324445;28261.57607635887;28298;29136.70863291361;2984.2091845660916;3042.4523585754555;3067.7392421644186;3199.9040028799172;3219.0342897130768;249296;250971.74514127497;251223;251255;251491;47465;48241.5175848244;53642.19536706952;53994;54771.726141369036;50812.74593627008;50990.74504627453;51045;51186.83384326197;51246;13898.444062237599;14026.719465610835;14029.719405611831;14053.156810591398;14091.71816563663;11045.282056666452;11076.833847492295;11115.221564549794;11146.331220126818;11176.944115279533;17422.56443588895;18025;18025.459236222934;18057.729134063;18068.728969065476;7237.167725711505;7413.625121786661;7462;7481.289277518627;7516.5114267572435;889.4218757807348;891.140049851896;1061.8354155105972;1068.7381591509975;1137.994310028461;24354.147604833746;25239;25645.743542564334;26784.823761744356;27081.45837083287;973.3819024919227;981.239539357004;1026.7895081508273;1097.0346095435966;1107.1419649771492;14038.789418158736;14073.648158796112;14253;14308.427662893368;14328.785068223984;314717;321837;322444;322617;323248;48526.75736621294;49471.25793113106;49474.50525494771;49501.75249123731;49567;1257.9559715409916;1349.5748839115647;1361.3057340756286;1364.4814970311218;1366.364640442219;25683.35791605225;26568.601470978338;26867.462650747268;26974;26988.460230795667;42914.35628465638;43121.137577248905;43198;43519.347209791245;43531.78234108809;225709;278941;286926;413553;413930;30104.397912042074;30377.24056898595;30420.847895761264;30544.847275763477;30862.845685771426;42103.15793684171;42571.57428425676;42743;43329;43652.56347436485;35637.97077248463;35831.64168358283;36122.63877361298;36605.450918236784;37523.81238093792;32089;32571.34857302888;32725.836370817993;34925.30149397049;35454.46818297676;33994.320113598085;34440.48339274963;34576.30847383088;34952.12619684426;35081;30364.392712146077;31761.20596985094;32403.18992025218;32453.18867028343;32506.51240231351;24389.51220975606;24754.257372278862;24787.25638230856;24839.379015524755;25087.372815679755 11:18:54 INFO - PROCESS | 3868 | |2;jquery.html;349.2891964851528;358.8026585378041;359.38365702819664;359.8614533404639;363.0451911472826;13670.521531746392;14085.084469509475;15896.284667189975;16004.67990640188;16360.263788129549;13784.517541886036;14935.775963360558;15133.470328538504;15148;16179;5430.511253987151;5563.916541251884;5578.163275508686;5582.86042848928;5586.748596313176;4070.0638853063815;4160.084781348114;5507.394186639466;5563.304586926634;5948.464638182562;5948.1375200595885;5971.611845230068;6027.276726792791;6027.608205466652;6033.758649654009;5302.787888484456;5431.918521222185;5460.099083651193;5467.507924286793;5990.071538911476;5176.016556854186;5242.266082748418;5245.6852588844795;5255.211718242294;5260.368755749297;12620.179688320322;12845.678858028625;12846.614601561969;12862.356882155855;16505.83494165067;1918.1464248409325;1963.3717210492648;2022.9898850505801;2041.0917141871873;2229.052652622629;8974.730758077269;9077.092290770936;9221.631134754669;9579.425234485952;9594.13652771247;1736.6439879824607;1738.3481194552044;1748.0909926837974;1780.857531397485;1798.9280428782833;54378.728106359216;55676.16485752717;56030.71984640091;61255.693721531105;62872;9786.41281523111;9836.114749672564;9854.359466634645;9880.555375008142;9895.119927213806;12561.937190313989;12593.748125037448;12601.306928119042;12611.684707882376;12634.115611907262;6830.59016459014;6883.65581720912;6926.2034865990045;6928.376446119873;7100.46746494015;6464.127342808661;6483.675816209265;6501.31736167705;6893.482988775761;6934.063901373351;4175.498940127204;4195.790210489463;4224.831006759757;4231.217224813419;4261.765602891871;1723.922423490946;1748.4142812157816;1769.716845304745;1772.8758986870796;1778.8754787165033;428.14584903118475;438.73895032455636;892.6786356911507;930.418488444722;1042.4943902207424;10484.4233567153;10870.891291087146;10958.671239862817;11089.05743011853;11120.721981950353;399.1856612510446;427.7390791617111;848.7665891879783;946.3990366117565;986.146982859821;7170.641467926687;8958;8998.50508222041;9028.277737780962;9145.3598248122;532477;536675;545310;549400;556369;80401.59799200967;80426;81180.18819811726;81327;82544.17455825485;1115.7210697325668;1123.9775204495863;1126.7971765082364;1129.2321221569412;1138.5901075612937;14313.212773297568;14502;14560.271986400849;14676.266186690837;14778.926105369404;33332.66667333393;33808;34019;34392;34531.654683453846;45406.77296613496;45706.54293457023;47449.52550474451;48159;48648.5135148644;9273.86089208649;9380.108889655472;9434.103760142776;9469.195118415011;9739.9026009739;10608.946955265174;10640.361578305326;10705.518251678848;10777.299475534066;13809;14403.063800852911;14460.566183014527;14687.92656036713;14740;14860;14098.859011409755;14310.141391516543;14319.856801431852;14471.782923255949;14528.418863245352;12044.457999389873;13472.393742281816;14213.289335532974;14228;15110.773338400153;9253.444793312154;9331.58007889633;9361.953190234006;9379;9432.717018489457;9871.358361706467;9938.204943604349;10112.963959117946;14144.43422263098;14159.929200353932 11:18:54 INFO - PROCESS | 3868 | |3;mootools.html;1211.0493262788702;1327.960161195164;1346.6431395680142;1425.6435891027243;1663.268162008717;6476;7075.292470752922;7188.993540904271;7194.316539928698;7196.6401679915925;6937.202221744501;7153.141623005234;7170.032045673833;7183.173934997477;7186.425085993121;1924.9326273580427;1951.5218771401026;1953.667876461005;2153.9030743616495;2179.6621523663857;2176.706144670473;2219.866807991518;2222.288867562381;2223.3885681437655;2223.4774827915426;2136.4872430616697;2160.8379371547117;2233.62028455163;2237.899294531742;2239.0819763896807;1920.5870737791372;1951.1512492065997;2123.819475344598;2160.8487405881597;2187.3000639795273;2130.3289463818846;2131.9467013324634;2149.183310342076;2152.9138834446603;2155.1810312081466;7092.822679433004;7132.4294056475355;7149.53528020677;7156;7156.499045066847;4162.729422587522;4199.622034016923;4205.663546916239;4231.238377092122;4237.87286381409;2837.9432411351863;2844.8008639395252;2880.15035564509;2882.4811533923885;2957.45287121881;899.1772528136747;899.7795540092719;912.1015799437548;918.0865039285886;930.418488444722;9313.767155821091;9395.20140788027;9415.340926135174;9416.717498475056;9421.76445588859;3837.175007373428;3837.6354246346555;3844.6539811417106;3872.9612703873163;4042.8989275268355;8191.79520511992;8199.508029518249;8206.58967051645;8209.09699933007;8212.917870821335;4316.676249281317;4337.067530480962;4339.262325404688;4354.521002689701;4355.651547876162;3964.365701487748;3964.841406343714;3968.523777146761;3969.3450580653866;3972.880813575597;3505.8422370992857;3528.576570811519;3529.6999755020597;3531.399662057456;3567.6789088981595;1074.5809134437575;1125.4597793059377;1134.773045390925;1141.2353723005606;1146.7133216695827;960.0879164793474;963.4123184857232;994.4530508220595;1001.1190152665607;1008.4100801031332;6873.072135261676;6892;6900.3099690031595;6914.101166848278;6919.827004324831;438.47602115471705;441.1904155873943;1123.6572845282103;1148.2134737704698;1161.9244749091451;5449.918251226235;5498.80754173602;5506.807261745819;5517.917231241535;5522.889542209134;8356.832863342821;8464.576771161417;8792.780180495538;8893.688720894737;8907.910920890838;8696.347773916981;8696.739097827076;8818.911810881937;8824.647014119491;8826.691065812665;6879.449644028466;6893.827654308682;6998.265182155902;7004.859902801915;7036.050133231948;6688.6990085445295;6704.564203326768;6737.696803643946;6751.223609284799;6754.155730533684;7689.346405555367;7814.88277675824;7837.568933708701;7923.881141782763;7967.641456134372;7536.284053014955;7769.223077692185;7774.144844067261;7781.37748980069;8127;6647;6657.40083392497;6665.666716664245;6738.561993470409;6744.022116793136;7112.715491380493;7116.8932466014085;7123.572585644878;7146.821329466805;7155.570665760071;6739.359760822714;6792.76225332111;6812;6864.450843932574;6889.552179108342;6513.934860651522;6677.69950352245;6685.39831415175;6721.798346049626;6739.797806065826;6568.6058836469965;6608.801735947929;6643.70103345341;6644.202695676549;6647.102641143384;5806.158107074535;5873.4126587340925;5880.441358070976;5907.3797251288;5927.288725352985;5997.820065398045;6023.3374328824675;6037.215162028908;6038.396160383926;6038.486728628116 11:18:54 INFO - PROCESS | 3868 | |4;prototype.html;328.0764647517239;328.8125768312062;330.3096528255945;333.576358025308;339.79951828421224;5908.852278693024;6090.543209259306;6094.2991555971075;6095.817125486237;6119.6328220306705;5832.300123985127;5984.162217289583;6000.849978750533;6016.217891674076;6027.578069535123;4658.138244424776;4658.697184683002;4659.976700116495;4661.627069834413;4671.92992105117;4414.536473670267;4464.843730469434;4520.593146616804;4611.400517932664;4657.301404789292;4576.542345765413;4587.885302867422;4596.2416201326905;4598.264277715566;4617;4600.884977875547;4603.125406172817;4608.838690645811;4610.193216187154;4619.307103934403;4051.0480037191237;4053.7365071270274;4054.108096218827;4057.9594204057876;4069.674426045909;5672.688002159921;5714.771409143629;5773.134029895507;5781.219535362714;5801.100829371454;5378.300820893298;5384.623076384654;5386.703731294777;5392.05639013175;5392.541633961118;6096.4817990470865;6377.553571250014;6382.553221274513;6382.808515744535;6388.265349484822;4372.081862808814;4375.16871794358;4469.709468884512;4472.932906006413;4502.189605870942;6638.966805165944;6653.900191497131;6686.665666716644;6697.832554186136;6700.765473208415;4626.653001024869;4633.698809577367;4633.837815676503;4636.327732478771;4636.35091087248;4389.736615803062;4471.35165401015;4500.549945005539;4690.108879312919;4696.9060618787435;5236.895262094813;5259.737013149327;5267.3152490176035;5267.9736601316745;5268;6414.454771344394;6449.451796597248;6458.5479016469335;6461.676916154268;6461.8061458156335;1587.8729701623843;1617.3692260018602;1617.5713435939485;1619.4251040880554;1620.6758648270393;1047.1831971062584;1056.3450660590483;1064.489045258265;1065.3181963543338;1090.1278976818514;6090.725917333731;6104.236970378703;6115.6330620162935;6115.938840611626;6124.265088189446;6628.502862285348;6635.037919501645;6643.435307998874;6644.036614690843;6647.734090636321;5965.880682386415;6095.085737139465;6097.664628445478;6097.878042439126;6106.328303886569;3566.375884220251;3597;3602.1715005548344;3604.1350075981577;3605.7295702822394;6852.383285504328;6865.725370985205;6869.656517174121;6871.725130994704;6875.037494750739;6647.86704265912;6761.560498567577;6769.120014398195;6778.93221067783;6780.694868730919;6803.591784492946;6855.4172895304455;6874.072000279998;6878.896816547655;6883.3116688330765;6375.649339286384;6506.967465162644;6508.284088750328;6611.438027767501;6623.966880165568;6535.085088087767;6552.082708420729;6598.769043083469;6610.140681711347;6612.801615951529;6878.621675807879;6911.861762764616;6913.412359949461;6922.169339679271;6925.3074692530345;4499.730016199039;4594.173048851105;4634.2353511671545;4645.721256724607;4649.209634362099;6596.868062638816;6600.80197594073;6601.702923368556;6605.306442823435;6613.404793568409;6422.582532135396;6491.545591808528;6491.772787952399;6493.318201588765;6496.382843629847;6334.176557047738;6469.029645553204;6482.092507048923;6537.346265373425;6545.770898018546;6350.872982540231;6392.968035159794;6401.903971440339;6403.807885763435;6406.967965160145;6571.178602674666;6582.76960306387;6584.50616203777;6586.814373412832;6590.308017658077;6250.656213908097;6420.6468644225015;6424.421802037839;6424.582402143846;6433.388828061326 11:18:54 INFO - PROCESS | 3868 | |5;yui.html;658.8484648530834;672.8553361027379;683.1597135523306;769.8537277917195;790.9802254943628;15539.53381398557;15692.45076422327;15722.606934826606;15737;15754.842451575481;14208.218547979857;14271.143731376125;14325.57023289303;14330.283485825694;14335.283235838193;681.7818298144596;690.0856365315951;813.3940214540175;813.5972693516688;826.900771907369;815.2866242038217;815.5514467043132;822.3708862719994;822.6257053040882;823.7899335669396;863.7236084452977;864.5245115186622;867.0852250875324;867.4925168776274;868.8783570300131;699.5872435263194;712.2343480758179;756.2513112019117;786.8386980669006;791.8257983243677;573.781962854117;575.7696921231541;580.6719203649924;580.7386675995776;580.9680467574282;13877.861221387859;13961.371738271802;13976;13992.370343334473;13996.30018499071;11981.940090299493;11996.64010079699;12020.879791202151;12273.079519036019;12333.198342107824;10109.443980581065;10208;10383.117435018032;10465.267431279814;10532.526036328383;3468.1849765305133;3543.255916257589;3568;3592.1558433768046;3632.891013269606;46259.30611040837;46563.06873862538;46800.53199467996;46891.29663055057;46901.76549117233;9901.653442129491;10026.097651211427;10103.444310562843;10136.391816491034;10152.23858210637;17399.391021314193;17644.91177544104;17658.11709414524;17686.469405917844;17723;7363.300486453778;7482.176960534337;7489.588072655947;7510.286522780327;7581.962090189514;4079.286124928126;4102.979485102555;4142.08874047709;4177.6866734995;4191.1827193697545;2859.1994241612383;2881.8991335303162;2882.12095310928;2882.3658795065053;2883.4377296426997;533.7758141580467;535.4912832808848;537.2451705353984;538.1362912525418;552.0366959655427;554.4483239177044;577.7775556410728;583.2417856786161;596.3678500789177;640.6508452893185;7414.518056326429;7619.809504762315;7941.841163176704;8624;9159.77100572491;486.51105638832746;490.08354377313935;630.5050535329744;637.2034956304619;692.5740669488329;3695.279420513028;3746.3069332173636;3785.432185172246;3884.1066554692015;3959.9604003960167;52085;52853;53871;57318.426815731305;58765;49484.75257623689;49762.50237497651;51040;51217;51546.22680659793;44617.77691111524;45170.54829451664;45339.09321813611;45695.08609827785;46304;7917;8075.798105047421;8088.150744172012;8207.097219305751;8213.342932565261;35761.64238357583;36273.45589816208;36840.44739328859;37065.81467092647;37155.25689486249;41861.79069104635;41974.58025419707;44109.55890441054;46417.76791116023;46824.531754682015;11126.109911207246;11168.776624467628;11177.832332514856;11340.262882912584;11520.827187592025;11373.090152787923;11382.146339024772;11571.594994175164;11927.46326415296;12324.753504930031;10664.57341706354;10773.461326933779;10802.405867677353;10838.566457341618;11170.27393219438;10994.670159895217;11100.389478578756;11375.886241137483;11379.08967282632;11751.118666100248;10680.305780124267;10795.73010674708;11241.156913231376;11252.60615878473;11592.88407115918;8707;8870.467771933705;8890.199882010651;9123.680671176477;9233.445993240428;7633.5419874807685;7703.422243331885;7744.303012728881;9191.448513089235;9197.31020173503 11:18:54 INFO - PROCESS | 3868 | __end_tp_report 11:18:54 INFO - PROCESS | 3868 | __start_cc_report 11:18:54 INFO - PROCESS | 3868 | _x_x_mozilla_cycle_collect,920 11:18:54 INFO - PROCESS | 3868 | __end_cc_report 11:18:54 INFO - PROCESS | 3868 | __startTimestamp1451330334227__endTimestamp 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | ------- Summary: start ------- 11:18:54 INFO - PROCESS | 3868 | Number of tests: 6 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#0] dojo.html Cycles:165 Average:5159.96 Median:5311.55 stddev:560.14 (10.5%) stddev-sans-first:537.43 11:18:54 INFO - PROCESS | 3868 | Values: 3074.3 3108.5 3149.6 3156.9 3172.8 5037.2 5118.7 5128.8 5151.5 5154.4 5143.0 5153.5 5166.8 5169.6 5205.3 4655.8 4724.3 4745.6 4758.1 4790.4 4684.6 4819.0 4833.0 4840.1 4847.2 4664.3 4717.3 4740.8 4777.7 4843.6 4623.5 4697.0 4725.3 4735.9 4761.7 4680.5 4684.5 4689.9 4695.8 4711.6 4924.9 4962.9 4982.0 5017.4 5041.1 5463.2 5513.8 5517.9 5523.6 5542.8 5566.4 5590.6 5592.3 5595.8 5595.9 5151.6 5190.5 5218.3 5229.7 5251.7 5694.8 5696.3 5716.3 5721.7 5748.4 5490.0 5499.8 5500.4 5502.7 5551.9 5422.4 5515.6 5580.5 5598.9 5603.5 5515.0 5598.1 5599.2 5604.9 5646.8 5493.5 5494.3 5497.3 5499.2 5499.5 4203.9 4274.4 4281.4 4291.4 4293.3 3876.1 3887.9 3892.4 3905.6 3919.0 5192.7 5208.5 5228.1 5230.8 5276.2 5394.9 5488.9 5493.4 5499.6 5593.9 5229.1 5244.8 5249.0 5253.0 5255.1 4821.7 4842.8 4847.6 4853.7 4889.0 5567.7 5695.6 5726.1 5754.0 5840.9 5573.7 5585.2 5588.4 5591.8 5600.1 5738.7 5748.8 5750.7 5756.1 5756.7 5367.3 5452.2 5459.3 5469.8 5576.9 5605.6 5607.5 5608.7 5610.0 5610.7 5406.6 5427.9 5479.6 5481.6 5519.3 5300.4 5383.8 5413.7 5438.9 5479.5 5287.4 5293.0 5297.1 5297.8 5299.1 5322.7 5380.1 5386.6 5438.4 5444.1 5299.0 5311.5 5346.0 5379.0 5418.8 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#1] ext.html Cycles:180 Average:45300.52 Median:34217.40 stddev:79729.47 (233.0%) stddev-sans-first:79882.36 11:18:54 INFO - PROCESS | 3868 | Values: 557.3 600.2 607.6 623.0 624.3 27925.3 28572.0 28606.6 28634.9 35602.0 38212.6 38668.6 38888.6 39026.2 39062.0 8430.5 8604.1 8619.9 8625.8 8626.3 7550.1 7630.7 7641.9 8350.4 10013.5 9863.1 9865.4 9912.2 9946.7 9948.0 9858.6 9959.5 9981.4 9983.6 9986.0 7529.3 7665.0 7672.0 9970.0 10209.6 35073.1 35392.1 35399.8 35401.6 35431.6 3128.7 3298.6 3822.1 3861.9 3902.1 27946.7 28108.6 28261.6 28298.0 29136.7 2984.2 3042.5 3067.7 3199.9 3219.0 249296.0 250971.7 251223.0 251255.0 251491.0 47465.0 48241.5 53642.2 53994.0 54771.7 50812.7 50990.7 51045.0 51186.8 51246.0 13898.4 14026.7 14029.7 14053.2 14091.7 11045.3 11076.8 11115.2 11146.3 11176.9 17422.6 18025.0 18025.5 18057.7 18068.7 7237.2 7413.6 7462.0 7481.3 7516.5 889.4 891.1 1061.8 1068.7 1138.0 24354.1 25239.0 25645.7 26784.8 27081.5 973.4 981.2 1026.8 1097.0 1107.1 14038.8 14073.6 14253.0 14308.4 14328.8 314717.0 321837.0 322444.0 322617.0 323248.0 48526.8 49471.3 49474.5 49501.8 49567.0 1258.0 1349.6 1361.3 1364.5 1366.4 25683.4 26568.6 26867.5 26974.0 26988.5 42914.4 43121.1 43198.0 43519.3 43531.8 225709.0 278941.0 286926.0 413553.0 413930.0 30104.4 30377.2 30420.8 30544.8 30862.8 42103.2 42571.6 42743.0 43329.0 43652.6 35638.0 35831.6 36122.6 36605.5 37523.8 32089.0 32571.3 32725.8 34925.3 35454.5 33994.3 34440.5 34576.3 34952.1 35081.0 30364.4 31761.2 32403.2 32453.2 32506.5 24389.5 24754.3 24787.3 24839.4 25087.4 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#2] jquery.html Cycles:180 Average:28117.72 Median:4246.49 stddev:89015.31 (2096.2%) stddev-sans-first:89240.60 11:18:54 INFO - PROCESS | 3868 | Values: 349.3 358.8 359.4 359.9 363.0 13670.5 14085.1 15896.3 16004.7 16360.3 13784.5 14935.8 15133.5 15148.0 16179.0 5430.5 5563.9 5578.2 5582.9 5586.7 4070.1 4160.1 5507.4 5563.3 5948.5 5948.1 5971.6 6027.3 6027.6 6033.8 5302.8 5431.9 5460.1 5467.5 5990.1 5176.0 5242.3 5245.7 5255.2 5260.4 12620.2 12845.7 12846.6 12862.4 16505.8 1918.1 1963.4 2023.0 2041.1 2229.1 8974.7 9077.1 9221.6 9579.4 9594.1 1736.6 1738.3 1748.1 1780.9 1798.9 54378.7 55676.2 56030.7 61255.7 62872.0 9786.4 9836.1 9854.4 9880.6 9895.1 12561.9 12593.7 12601.3 12611.7 12634.1 6830.6 6883.7 6926.2 6928.4 7100.5 6464.1 6483.7 6501.3 6893.5 6934.1 4175.5 4195.8 4224.8 4231.2 4261.8 1723.9 1748.4 1769.7 1772.9 1778.9 428.1 438.7 892.7 930.4 1042.5 10484.4 10870.9 10958.7 11089.1 11120.7 399.2 427.7 848.8 946.4 986.1 7170.6 8958.0 8998.5 9028.3 9145.4 532477.0 536675.0 545310.0 549400.0 556369.0 80401.6 80426.0 81180.2 81327.0 82544.2 1115.7 1124.0 1126.8 1129.2 1138.6 14313.2 14502.0 14560.3 14676.3 14778.9 33332.7 33808.0 34019.0 34392.0 34531.7 45406.8 45706.5 47449.5 48159.0 48648.5 9273.9 9380.1 9434.1 9469.2 9739.9 10608.9 10640.4 10705.5 10777.3 13809.0 14403.1 14460.6 14687.9 14740.0 14860.0 14098.9 14310.1 14319.9 14471.8 14528.4 12044.5 13472.4 14213.3 14228.0 15110.8 9253.4 9331.6 9362.0 9379.0 9432.7 9871.4 9938.2 10113.0 14144.4 14159.9 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#3] mootools.html Cycles:180 Average:5074.13 Median:6626.25 stddev:2613.06 (39.4%) stddev-sans-first:2604.25 11:18:54 INFO - PROCESS | 3868 | Values: 1211.0 1328.0 1346.6 1425.6 1663.3 6476.0 7075.3 7189.0 7194.3 7196.6 6937.2 7153.1 7170.0 7183.2 7186.4 1924.9 1951.5 1953.7 2153.9 2179.7 2176.7 2219.9 2222.3 2223.4 2223.5 2136.5 2160.8 2233.6 2237.9 2239.1 1920.6 1951.2 2123.8 2160.8 2187.3 2130.3 2131.9 2149.2 2152.9 2155.2 7092.8 7132.4 7149.5 7156.0 7156.5 4162.7 4199.6 4205.7 4231.2 4237.9 2837.9 2844.8 2880.2 2882.5 2957.5 899.2 899.8 912.1 918.1 930.4 9313.8 9395.2 9415.3 9416.7 9421.8 3837.2 3837.6 3844.7 3873.0 4042.9 8191.8 8199.5 8206.6 8209.1 8212.9 4316.7 4337.1 4339.3 4354.5 4355.7 3964.4 3964.8 3968.5 3969.3 3972.9 3505.8 3528.6 3529.7 3531.4 3567.7 1074.6 1125.5 1134.8 1141.2 1146.7 960.1 963.4 994.5 1001.1 1008.4 6873.1 6892.0 6900.3 6914.1 6919.8 438.5 441.2 1123.7 1148.2 1161.9 5449.9 5498.8 5506.8 5517.9 5522.9 8356.8 8464.6 8792.8 8893.7 8907.9 8696.3 8696.7 8818.9 8824.6 8826.7 6879.4 6893.8 6998.3 7004.9 7036.1 6688.7 6704.6 6737.7 6751.2 6754.2 7689.3 7814.9 7837.6 7923.9 7967.6 7536.3 7769.2 7774.1 7781.4 8127.0 6647.0 6657.4 6665.7 6738.6 6744.0 7112.7 7116.9 7123.6 7146.8 7155.6 6739.4 6792.8 6812.0 6864.5 6889.6 6513.9 6677.7 6685.4 6721.8 6739.8 6568.6 6608.8 6643.7 6644.2 6647.1 5806.2 5873.4 5880.4 5907.4 5927.3 5997.8 6023.3 6037.2 6038.4 6038.5 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#4] prototype.html Cycles:180 Average:5372.28 Median:6095.45 stddev:1625.00 (26.7%) stddev-sans-first:1584.84 11:18:54 INFO - PROCESS | 3868 | Values: 328.1 328.8 330.3 333.6 339.8 5908.9 6090.5 6094.3 6095.8 6119.6 5832.3 5984.2 6000.8 6016.2 6027.6 4658.1 4658.7 4660.0 4661.6 4671.9 4414.5 4464.8 4520.6 4611.4 4657.3 4576.5 4587.9 4596.2 4598.3 4617.0 4600.9 4603.1 4608.8 4610.2 4619.3 4051.0 4053.7 4054.1 4058.0 4069.7 5672.7 5714.8 5773.1 5781.2 5801.1 5378.3 5384.6 5386.7 5392.1 5392.5 6096.5 6377.6 6382.6 6382.8 6388.3 4372.1 4375.2 4469.7 4472.9 4502.2 6639.0 6653.9 6686.7 6697.8 6700.8 4626.7 4633.7 4633.8 4636.3 4636.4 4389.7 4471.4 4500.5 4690.1 4696.9 5236.9 5259.7 5267.3 5268.0 5268.0 6414.5 6449.5 6458.5 6461.7 6461.8 1587.9 1617.4 1617.6 1619.4 1620.7 1047.2 1056.3 1064.5 1065.3 1090.1 6090.7 6104.2 6115.6 6115.9 6124.3 6628.5 6635.0 6643.4 6644.0 6647.7 5965.9 6095.1 6097.7 6097.9 6106.3 3566.4 3597.0 3602.2 3604.1 3605.7 6852.4 6865.7 6869.7 6871.7 6875.0 6647.9 6761.6 6769.1 6778.9 6780.7 6803.6 6855.4 6874.1 6878.9 6883.3 6375.6 6507.0 6508.3 6611.4 6624.0 6535.1 6552.1 6598.8 6610.1 6612.8 6878.6 6911.9 6913.4 6922.2 6925.3 4499.7 4594.2 4634.2 4645.7 4649.2 6596.9 6600.8 6601.7 6605.3 6613.4 6422.6 6491.5 6491.8 6493.3 6496.4 6334.2 6469.0 6482.1 6537.3 6545.8 6350.9 6393.0 6401.9 6403.8 6407.0 6571.2 6582.8 6584.5 6586.8 6590.3 6250.7 6420.6 6424.4 6424.6 6433.4 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - PROCESS | 3868 | [#5] yui.html Cycles:180 Average:13625.29 Median:45977.20 stddev:15673.30 (34.1%) stddev-sans-first:15687.01 11:18:54 INFO - PROCESS | 3868 | Values: 658.8 672.9 683.2 769.9 791.0 15539.5 15692.5 15722.6 15737.0 15754.8 14208.2 14271.1 14325.6 14330.3 14335.3 681.8 690.1 813.4 813.6 826.9 815.3 815.6 822.4 822.6 823.8 863.7 864.5 867.1 867.5 868.9 699.6 712.2 756.3 786.8 791.8 573.8 575.8 580.7 580.7 581.0 13877.9 13961.4 13976.0 13992.4 13996.3 11981.9 11996.6 12020.9 12273.1 12333.2 10109.4 10208.0 10383.1 10465.3 10532.5 3468.2 3543.3 3568.0 3592.2 3632.9 46259.3 46563.1 46800.5 46891.3 46901.8 9901.7 10026.1 10103.4 10136.4 10152.2 17399.4 17644.9 17658.1 17686.5 17723.0 7363.3 7482.2 7489.6 7510.3 7582.0 4079.3 4103.0 4142.1 4177.7 4191.2 2859.2 2881.9 2882.1 2882.4 2883.4 533.8 535.5 537.2 538.1 552.0 554.4 577.8 583.2 596.4 640.7 7414.5 7619.8 7941.8 8624.0 9159.8 486.5 490.1 630.5 637.2 692.6 3695.3 3746.3 3785.4 3884.1 3960.0 52085.0 52853.0 53871.0 57318.4 58765.0 49484.8 49762.5 51040.0 51217.0 51546.2 44617.8 45170.5 45339.1 45695.1 46304.0 7917.0 8075.8 8088.2 8207.1 8213.3 35761.6 36273.5 36840.4 37065.8 37155.3 41861.8 41974.6 44109.6 46417.8 46824.5 11126.1 11168.8 11177.8 11340.3 11520.8 11373.1 11382.1 11571.6 11927.5 12324.8 10664.6 10773.5 10802.4 10838.6 11170.3 10994.7 11100.4 11375.9 11379.1 11751.1 10680.3 10795.7 11241.2 11252.6 11592.9 8707.0 8870.5 8890.2 9123.7 9233.4 7633.5 7703.4 7744.3 9191.4 9197.3 11:18:54 INFO - PROCESS | 3868 | -------- Summary: end -------- 11:18:54 INFO - PROCESS | 3868 | 11:18:54 INFO - TEST-INFO | 3868: exit 0 11:18:55 INFO - TEST-OK | dromaeo_css | took 1112211ms 11:18:55 INFO - TEST-START | kraken 11:18:55 INFO - operating with platform_type : linux_ 11:18:55 INFO - Initialising browser for kraken test... 11:18:55 INFO - TEST-INFO | started process 4056 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTbx4fd/profile http://localhost:52717/getInfo.html) 11:18:58 INFO - PROCESS | 4056 | __metrics Screen width/height:1600/1200 11:18:58 INFO - PROCESS | 4056 | colorDepth:24 11:18:58 INFO - PROCESS | 4056 | Browser inner width/height: 1024/697 11:18:58 INFO - PROCESS | 4056 | __metrics 11:18:58 INFO - PROCESS | 4056 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:18:58 INFO - PROCESS | 4056 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:59 INFO - TEST-INFO | 4056: exit 0 11:18:59 INFO - Browser initialized. 11:18:59 INFO - Running cycle 1/1 for kraken test... 11:18:59 INFO - TEST-INFO | started process 4139 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTbx4fd/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:11 INFO - PROCESS | 4139 | RSS: Main: 148541440 11:19:11 INFO - PROCESS | 4139 | 11:19:14 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52717/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:14 INFO - PROCESS | 4139 | RSS: Main: 185425920 11:19:14 INFO - PROCESS | 4139 | 11:19:17 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52717/tests/kraken/driver.html?testName=audio-dft) 11:19:17 INFO - PROCESS | 4139 | RSS: Main: 173854720 11:19:17 INFO - PROCESS | 4139 | 11:19:20 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52717/tests/kraken/driver.html?testName=audio-fft) 11:19:21 INFO - PROCESS | 4139 | RSS: Main: 160899072 11:19:21 INFO - PROCESS | 4139 | 11:19:23 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52717/tests/kraken/driver.html?testName=audio-oscillator) 11:19:23 INFO - PROCESS | 4139 | RSS: Main: 162406400 11:19:23 INFO - PROCESS | 4139 | 11:19:26 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:26 INFO - PROCESS | 4139 | RSS: Main: 165412864 11:19:26 INFO - PROCESS | 4139 | 11:19:29 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52717/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:30 INFO - PROCESS | 4139 | RSS: Main: 164720640 11:19:30 INFO - PROCESS | 4139 | 11:19:33 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52717/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:34 INFO - PROCESS | 4139 | RSS: Main: 164990976 11:19:34 INFO - PROCESS | 4139 | 11:19:36 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52717/tests/kraken/driver.html?testName=json-parse-financial) 11:19:37 INFO - PROCESS | 4139 | RSS: Main: 165638144 11:19:37 INFO - PROCESS | 4139 | 11:19:38 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:39 INFO - PROCESS | 4139 | RSS: Main: 184123392 11:19:39 INFO - PROCESS | 4139 | 11:19:41 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:41 INFO - PROCESS | 4139 | RSS: Main: 179679232 11:19:41 INFO - PROCESS | 4139 | 11:19:43 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:44 INFO - PROCESS | 4139 | RSS: Main: 190107648 11:19:44 INFO - PROCESS | 4139 | 11:19:46 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:47 INFO - PROCESS | 4139 | RSS: Main: 195379200 11:19:47 INFO - PROCESS | 4139 | 11:19:50 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:50 INFO - PROCESS | 4139 | RSS: Main: 192479232 11:19:50 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | Cycle 1(1): loaded http://localhost:52717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52717/tests/kraken/driver.html?testName=ai-astar) 11:19:52 INFO - PROCESS | 4139 | RSS: Main: 250667008 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | __start_tp_report 11:19:52 INFO - PROCESS | 4139 | _x_x_mozilla_page_load 11:19:52 INFO - PROCESS | 4139 | _x_x_mozilla_page_load_details 11:19:52 INFO - PROCESS | 4139 | |i|pagename|runs| 11:19:52 INFO - PROCESS | 4139 | |0;ai-astar;109;110;105;110;112;111;100;110;110;100 11:19:52 INFO - PROCESS | 4139 | |1;audio-beat-detection;149;127;144;160;124;151;152;125;174;124 11:19:52 INFO - PROCESS | 4139 | |2;audio-dft;160;159;158;159;161;162;161;161;159;163 11:19:52 INFO - PROCESS | 4139 | |3;audio-fft;71;70;90;93;72;70;71;101;89;74 11:19:52 INFO - PROCESS | 4139 | |4;audio-oscillator;96;96;138;95;96;95;141;95;95;146 11:19:52 INFO - PROCESS | 4139 | |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;110 11:19:52 INFO - PROCESS | 4139 | |6;imaging-darkroom;146;147;145;146;146;145;147;147;146;145 11:19:52 INFO - PROCESS | 4139 | |7;imaging-desaturate;95;95;96;95;96;95;95;96;96;96 11:19:52 INFO - PROCESS | 4139 | |8;json-parse-financial;59;58;56;57;57;57;56;57;67;54 11:19:52 INFO - PROCESS | 4139 | |9;json-stringify-tinderbox;68;67;68;68;68;68;68;69;68;67 11:19:52 INFO - PROCESS | 4139 | |10;stanford-crypto-aes;83;91;85;86;94;90;85;86;87;87 11:19:52 INFO - PROCESS | 4139 | |11;stanford-crypto-ccm;132;120;119;120;119;113;133;116;118;130 11:19:52 INFO - PROCESS | 4139 | |12;stanford-crypto-pbkdf2;141;150;150;157;154;149;160;152;150;147 11:19:52 INFO - PROCESS | 4139 | |13;stanford-crypto-sha256-iterative;76;68;67;67;68;68;67;67;66;65 11:19:52 INFO - PROCESS | 4139 | __end_tp_report 11:19:52 INFO - PROCESS | 4139 | __start_cc_report 11:19:52 INFO - PROCESS | 4139 | _x_x_mozilla_cycle_collect,898 11:19:52 INFO - PROCESS | 4139 | __end_cc_report 11:19:52 INFO - PROCESS | 4139 | __startTimestamp1451330392584__endTimestamp 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | ------- Summary: start ------- 11:19:52 INFO - PROCESS | 4139 | Number of tests: 14 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#0] ai-astar Cycles:10 Average:107.70 Median:110.00 stddev:4.45 (4.0%) stddev-sans-first:4.69 11:19:52 INFO - PROCESS | 4139 | Values: 109.0 110.0 105.0 110.0 112.0 111.0 100.0 110.0 110.0 100.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:150.00 stddev:17.43 (11.6%) stddev-sans-first:18.35 11:19:52 INFO - PROCESS | 4139 | Values: 149.0 127.0 144.0 160.0 124.0 151.0 152.0 125.0 174.0 124.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.57 (1.0%) stddev-sans-first:1.66 11:19:52 INFO - PROCESS | 4139 | Values: 160.0 159.0 158.0 159.0 161.0 162.0 161.0 161.0 159.0 163.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:11.80 (16.2%) stddev-sans-first:12.05 11:19:52 INFO - PROCESS | 4139 | Values: 71.0 70.0 90.0 93.0 72.0 70.0 71.0 101.0 89.0 74.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:95.00 stddev:22.42 (23.6%) stddev-sans-first:23.26 11:19:52 INFO - PROCESS | 4139 | Values: 96.0 96.0 138.0 95.0 96.0 95.0 141.0 95.0 95.0 146.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:19:52 INFO - PROCESS | 4139 | Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 11:19:52 INFO - PROCESS | 4139 | Values: 146.0 147.0 145.0 146.0 146.0 145.0 147.0 147.0 146.0 145.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:19:52 INFO - PROCESS | 4139 | Values: 95.0 95.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:3.49 (6.1%) stddev-sans-first:3.67 11:19:52 INFO - PROCESS | 4139 | Values: 59.0 58.0 56.0 57.0 57.0 57.0 56.0 57.0 67.0 54.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 11:19:52 INFO - PROCESS | 4139 | Values: 68.0 67.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 67.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.00 stddev:3.31 (3.8%) stddev-sans-first:3.10 11:19:52 INFO - PROCESS | 4139 | Values: 83.0 91.0 85.0 86.0 94.0 90.0 85.0 86.0 87.0 87.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:120.00 stddev:7.02 (5.9%) stddev-sans-first:6.45 11:19:52 INFO - PROCESS | 4139 | Values: 132.0 120.0 119.0 120.0 119.0 113.0 133.0 116.0 118.0 130.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.00 Median:151.00 stddev:5.27 (3.5%) stddev-sans-first:4.17 11:19:52 INFO - PROCESS | 4139 | Values: 141.0 150.0 150.0 157.0 154.0 149.0 160.0 152.0 150.0 147.0 11:19:52 INFO - PROCESS | 4139 | 11:19:52 INFO - PROCESS | 4139 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:3.00 (4.4%) stddev-sans-first:1.00 11:19:52 INFO - PROCESS | 4139 | Values: 76.0 68.0 67.0 67.0 68.0 68.0 67.0 67.0 66.0 65.0 11:19:52 INFO - PROCESS | 4139 | -------- Summary: end -------- 11:19:52 INFO - PROCESS | 4139 | 11:19:53 INFO - TEST-INFO | 4139: exit 0 11:19:53 INFO - TEST-OK | kraken | took 58483ms 11:19:53 INFO - TEST-START | v8_7 11:19:53 INFO - operating with platform_type : linux_ 11:19:53 INFO - Initialising browser for v8_7 test... 11:19:53 INFO - TEST-INFO | started process 4390 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEDzP7b/profile http://localhost:52717/getInfo.html) 11:19:57 INFO - PROCESS | 4390 | __metrics Screen width/height:1600/1200 11:19:57 INFO - PROCESS | 4390 | colorDepth:24 11:19:57 INFO - PROCESS | 4390 | Browser inner width/height: 1024/697 11:19:57 INFO - PROCESS | 4390 | __metrics 11:19:57 INFO - PROCESS | 4390 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:19:57 INFO - PROCESS | 4390 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:58 INFO - TEST-INFO | 4390: exit 0 11:19:58 INFO - Browser initialized. 11:19:58 INFO - Running cycle 1/1 for v8_7 test... 11:19:58 INFO - TEST-INFO | started process 4470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpEDzP7b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:10 INFO - PROCESS | 4470 | RSS: Main: 148709376 11:20:10 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | Cycle 1(1): loaded http://localhost:52717/tests/v8_7/run.html (next: http://localhost:52717/tests/v8_7/run.html) 11:20:31 INFO - PROCESS | 4470 | RSS: Main: 545030144 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | __start_tp_report 11:20:31 INFO - PROCESS | 4470 | _x_x_mozilla_page_load 11:20:31 INFO - PROCESS | 4470 | _x_x_mozilla_page_load_details 11:20:31 INFO - PROCESS | 4470 | |i|pagename|runs| 11:20:31 INFO - PROCESS | 4470 | |0;Richards;167.84155756965424 11:20:31 INFO - PROCESS | 4470 | |1;DeltaBlue;190.43991620643686 11:20:31 INFO - PROCESS | 4470 | |2;Encrypt;280.97780275358247 11:20:31 INFO - PROCESS | 4470 | |3;Decrypt;5164.948453608247 11:20:31 INFO - PROCESS | 4470 | |4;RayTrace;1992.03187250996 11:20:31 INFO - PROCESS | 4470 | |5;Earley;800.640512409928 11:20:31 INFO - PROCESS | 4470 | |6;Boyer;12243.90243902439 11:20:31 INFO - PROCESS | 4470 | |7;RegExp;26230.76923076923 11:20:31 INFO - PROCESS | 4470 | |8;Splay;604.5949214026602 11:20:31 INFO - PROCESS | 4470 | |9;NavierStokes;4850.241545893719 11:20:31 INFO - PROCESS | 4470 | __end_tp_report 11:20:31 INFO - PROCESS | 4470 | __startTimestamp1451330431831__endTimestamp 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | ------- Summary: start ------- 11:20:31 INFO - PROCESS | 4470 | Number of tests: 10 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#0] Richards Cycles:1 Average:167.84 Median:167.84 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 167.8 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#1] DeltaBlue Cycles:1 Average:190.44 Median:190.44 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 190.4 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 281.0 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 5164.9 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 1992.0 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#5] Earley Cycles:1 Average:800.64 Median:800.64 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 800.6 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 12243.9 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#7] RegExp Cycles:1 Average:26230.77 Median:26230.77 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 26230.8 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 604.6 11:20:31 INFO - PROCESS | 4470 | 11:20:31 INFO - PROCESS | 4470 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 11:20:31 INFO - PROCESS | 4470 | Values: 4850.2 11:20:31 INFO - PROCESS | 4470 | -------- Summary: end -------- 11:20:31 INFO - PROCESS | 4470 | 11:20:32 INFO - TEST-INFO | 4470: exit 0 11:20:32 INFO - TEST-OK | v8_7 | took 39183ms 11:20:32 INFO - SUITE-END | took 1209s 11:20:32 INFO - Completed test suite (00:20:10) 11:20:32 INFO - Working with test: dromaeo_css 11:20:32 INFO - Generating results file: dromaeo_css 11:20:32 INFO - Working with test: kraken 11:20:32 INFO - Generating results file: kraken 11:20:32 INFO - javascript benchmark 11:20:32 INFO - Working with test: v8_7 11:20:32 INFO - Generating results file: v8_7 11:20:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:20:33 INFO - process_Request line: dromaeo_css 6718.19 graph.html#tests=[[72,201,35]] 11:20:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:33 INFO - process_Request line: kraken 1505.20 graph.html#tests=[[232,201,35]] 11:20:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:20:33 INFO - process_Request line: v8_7 19728.42 graph.html#tests=[[230,201,35]] 11:20:33 INFO - RETURN: dromaeo_css: 6718.19 11:20:33 INFO - RETURN: kraken: 1505.20 11:20:33 INFO - RETURN: v8_7: 19728.42 11:20:33 INFO - javascript benchmark 11:20:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3074.308280636856, 3108.549260357247, 3149.59055322808, 3156.9052928412143, 3172.7937684050535, 5037.1688671369275, 5118.718470484127, 5128.820491282801, 5151.459096794834, 5154.355705536808, 5142.974285128578, 5153.4846515348445, 5166.819161329354, 5169.638125331228, 5205.349331333583, 4655.790489427967, 4724.338592597039, 4745.59662428694, 4758.143534163849, 4790.377250957371, 4684.578387945085, 4818.951810481903, 4833.0, 4840.080384726908, 4847.2002119650215, 4664.253719404879, 4717.268823332389, 4740.834070807539, 4777.737224452654, 4843.564079232869, 4623.491415944277, 4697.0, 4725.267583524559, 4735.928961065587, 4761.6904901181315, 4680.531946805327, 4684.484706682262, 4689.906201875978, 4695.788689508946, 4711.599514041311, 4924.901501969976, 4962.87592810179, 4982.0, 5017.422996355393, 5041.067402530543, 5463.2078348639625, 5513.751881165357, 5517.917231241535, 5523.6409633374105, 5542.8337149885565, 5566.387697353288, 5590.580706447033, 5592.273004509388, 5595.832125036255, 5595.8880822383735, 5151.5621172200035, 5190.455002224788, 5218.321618189611, 5229.738513074331, 5251.68489890604, 5694.800681976111, 5696.259486266758, 5716.28546431696, 5721.742521586539, 5748.425157484218, 5490.0, 5499.780008799603, 5500.367457742331, 5502.697351645618, 5551.861203469864, 5422.43064478232, 5515.641483303572, 5580.525655319343, 5598.86002849932, 5603.467670571289, 5515.0, 5598.10430331145, 5599.188117722907, 5604.85987850307, 5646.802361917313, 5493.450654934474, 5494.313210848644, 5497.285352904097, 5499.202615620713, 5499.50504454601, 4203.91592168155, 4274.358846173099, 4281.422008028939, 4291.420658211164, 4293.334533147367, 3876.1278712290073, 3887.902802429962, 3892.3966785148345, 3905.5899130591447, 3919.0, 5192.688438693691, 5208.5312321891215, 5228.085085110167, 5230.764615592308, 5276.208568714724, 5394.91907621386, 5488.890222195534, 5493.395726470085, 5499.560035197174, 5593.916091258634, 5229.137192363293, 5244.763985620656, 5249.0, 5252.973735131376, 5255.132903071027, 4821.710697358169, 4842.782074806642, 4847.587955023792, 4853.6602437829015, 4889.046635905964, 5567.693776842231, 5695.572832037614, 5726.112452569859, 5754.0, 5840.912386314294, 5573.749181286933, 5585.1901474286815, 5588.41321661236, 5591.804286849941, 5600.103983362643, 5738.713064346849, 5748.798792042258, 5750.712464376848, 5756.079027355603, 5756.71216439168, 5367.329083864517, 5452.182172673972, 5459.2629994950175, 5469.808556700496, 5576.888462230814, 5605.607607467438, 5607.467290607386, 5608.719564021864, 5609.971950140223, 5610.7194640268635, 5406.648567843077, 5427.918581221206, 5479.643823151642, 5481.588880833874, 5519.254900588529, 5300.416954135119, 5383.7846486140115, 5413.675179489243, 5438.891222175614, 5479.479449452296, 5287.365516138088, 5293.0, 5297.125974214211, 5297.761600727899, 5299.125644268653, 5322.654027488201, 5380.085385484555, 5386.59600529954, 5438.374586922555, 5444.1017232156255, 5299.0, 5311.548518375981, 5345.957538279998, 5379.031774280511, 5418.756155972912], "unit": "score", "name": "dojo.html", "value": 5124.507369169803}, {"lowerIsBetter": false, "replicates": [557.3172863242528, 600.2167171840747, 607.6263098194609, 622.9781957631484, 624.3226099681845, 27925.301867453298, 28572.0, 28606.57090143647, 28634.856825715895, 35602.0, 38212.617873821255, 38668.61331386685, 38888.61111388885, 39026.21947561047, 39062.0, 8430.536320502386, 8604.053554109074, 8619.870701939475, 8625.827483450326, 8626.309895208367, 7550.093988721361, 7630.694772209105, 7641.923580764204, 8350.415470917038, 10013.499325033756, 9863.112319891208, 9865.358751681153, 9912.207023438108, 9946.65186718465, 9947.950260248688, 9858.556364963593, 9959.502024898798, 9981.351212171186, 9983.550740216635, 9986.0, 7529.322360987483, 7664.961675191644, 7672.0, 9970.0, 10209.591616335338, 35073.1231719209, 35392.11519712002, 35399.82300088509, 35401.64598354035, 35431.645683543094, 3128.671489493593, 3298.620658624241, 3822.10180607557, 3861.8841434757, 3902.1025164212106, 27946.720532794818, 28108.578371324445, 28261.57607635887, 28298.0, 29136.70863291361, 2984.2091845660916, 3042.4523585754555, 3067.7392421644186, 3199.9040028799172, 3219.0342897130768, 249296.0, 250971.74514127497, 251223.0, 251255.0, 251491.0, 47465.0, 48241.5175848244, 53642.19536706952, 53994.0, 54771.726141369036, 50812.74593627008, 50990.74504627453, 51045.0, 51186.83384326197, 51246.0, 13898.444062237599, 14026.719465610835, 14029.719405611831, 14053.156810591398, 14091.71816563663, 11045.282056666452, 11076.833847492295, 11115.221564549794, 11146.331220126818, 11176.944115279533, 17422.56443588895, 18025.0, 18025.459236222934, 18057.729134063, 18068.728969065476, 7237.167725711505, 7413.625121786661, 7462.0, 7481.289277518627, 7516.5114267572435, 889.4218757807348, 891.140049851896, 1061.8354155105972, 1068.7381591509975, 1137.994310028461, 24354.147604833746, 25239.0, 25645.743542564334, 26784.823761744356, 27081.45837083287, 973.3819024919227, 981.239539357004, 1026.7895081508273, 1097.0346095435966, 1107.1419649771492, 14038.789418158736, 14073.648158796112, 14253.0, 14308.427662893368, 14328.785068223984, 314717.0, 321837.0, 322444.0, 322617.0, 323248.0, 48526.75736621294, 49471.25793113106, 49474.50525494771, 49501.75249123731, 49567.0, 1257.9559715409916, 1349.5748839115647, 1361.3057340756286, 1364.4814970311218, 1366.364640442219, 25683.35791605225, 26568.601470978338, 26867.462650747268, 26974.0, 26988.460230795667, 42914.35628465638, 43121.137577248905, 43198.0, 43519.347209791245, 43531.78234108809, 225709.0, 278941.0, 286926.0, 413553.0, 413930.0, 30104.397912042074, 30377.24056898595, 30420.847895761264, 30544.847275763477, 30862.845685771426, 42103.15793684171, 42571.57428425676, 42743.0, 43329.0, 43652.56347436485, 35637.97077248463, 35831.64168358283, 36122.63877361298, 36605.450918236784, 37523.81238093792, 32089.0, 32571.34857302888, 32725.836370817993, 34925.30149397049, 35454.46818297676, 33994.320113598085, 34440.48339274963, 34576.30847383088, 34952.12619684426, 35081.0, 30364.392712146077, 31761.20596985094, 32403.18992025218, 32453.18867028343, 32506.51240231351, 24389.51220975606, 24754.257372278862, 24787.25638230856, 24839.379015524755, 25087.372815679755], "unit": "score", "name": "ext.html", "value": 17704.61731171196}, {"lowerIsBetter": false, "replicates": [349.2891964851528, 358.8026585378041, 359.38365702819664, 359.8614533404639, 363.0451911472826, 13670.521531746392, 14085.084469509475, 15896.284667189975, 16004.67990640188, 16360.263788129549, 13784.517541886036, 14935.775963360558, 15133.470328538504, 15148.0, 16179.0, 5430.511253987151, 5563.916541251884, 5578.163275508686, 5582.86042848928, 5586.748596313176, 4070.0638853063815, 4160.084781348114, 5507.394186639466, 5563.304586926634, 5948.464638182562, 5948.1375200595885, 5971.611845230068, 6027.276726792791, 6027.608205466652, 6033.758649654009, 5302.787888484456, 5431.918521222185, 5460.099083651193, 5467.507924286793, 5990.071538911476, 5176.016556854186, 5242.266082748418, 5245.6852588844795, 5255.211718242294, 5260.368755749297, 12620.179688320322, 12845.678858028625, 12846.614601561969, 12862.356882155855, 16505.83494165067, 1918.1464248409325, 1963.3717210492648, 2022.9898850505801, 2041.0917141871873, 2229.052652622629, 8974.730758077269, 9077.092290770936, 9221.631134754669, 9579.425234485952, 9594.13652771247, 1736.6439879824607, 1738.3481194552044, 1748.0909926837974, 1780.857531397485, 1798.9280428782833, 54378.728106359216, 55676.16485752717, 56030.71984640091, 61255.693721531105, 62872.0, 9786.41281523111, 9836.114749672564, 9854.359466634645, 9880.555375008142, 9895.119927213806, 12561.937190313989, 12593.748125037448, 12601.306928119042, 12611.684707882376, 12634.115611907262, 6830.59016459014, 6883.65581720912, 6926.2034865990045, 6928.376446119873, 7100.46746494015, 6464.127342808661, 6483.675816209265, 6501.31736167705, 6893.482988775761, 6934.063901373351, 4175.498940127204, 4195.790210489463, 4224.831006759757, 4231.217224813419, 4261.765602891871, 1723.922423490946, 1748.4142812157816, 1769.716845304745, 1772.8758986870796, 1778.8754787165033, 428.14584903118475, 438.73895032455636, 892.6786356911507, 930.418488444722, 1042.4943902207424, 10484.4233567153, 10870.891291087146, 10958.671239862817, 11089.05743011853, 11120.721981950353, 399.1856612510446, 427.7390791617111, 848.7665891879783, 946.3990366117565, 986.146982859821, 7170.641467926687, 8958.0, 8998.50508222041, 9028.277737780962, 9145.3598248122, 532477.0, 536675.0, 545310.0, 549400.0, 556369.0, 80401.59799200967, 80426.0, 81180.18819811726, 81327.0, 82544.17455825485, 1115.7210697325668, 1123.9775204495863, 1126.7971765082364, 1129.2321221569412, 1138.5901075612937, 14313.212773297568, 14502.0, 14560.271986400849, 14676.266186690837, 14778.926105369404, 33332.66667333393, 33808.0, 34019.0, 34392.0, 34531.654683453846, 45406.77296613496, 45706.54293457023, 47449.52550474451, 48159.0, 48648.5135148644, 9273.86089208649, 9380.108889655472, 9434.103760142776, 9469.195118415011, 9739.9026009739, 10608.946955265174, 10640.361578305326, 10705.518251678848, 10777.299475534066, 13809.0, 14403.063800852911, 14460.566183014527, 14687.92656036713, 14740.0, 14860.0, 14098.859011409755, 14310.141391516543, 14319.856801431852, 14471.782923255949, 14528.418863245352, 12044.457999389873, 13472.393742281816, 14213.289335532974, 14228.0, 15110.773338400153, 9253.444793312154, 9331.58007889633, 9361.953190234006, 9379.0, 9432.717018489457, 9871.358361706467, 9938.204943604349, 10112.963959117946, 14144.43422263098, 14159.929200353932], "unit": "score", "name": "jquery.html", "value": 8227.12872131417}, {"lowerIsBetter": false, "replicates": [1211.0493262788702, 1327.960161195164, 1346.6431395680142, 1425.6435891027243, 1663.268162008717, 6476.0, 7075.292470752922, 7188.993540904271, 7194.316539928698, 7196.6401679915925, 6937.202221744501, 7153.141623005234, 7170.032045673833, 7183.173934997477, 7186.425085993121, 1924.9326273580427, 1951.5218771401026, 1953.667876461005, 2153.9030743616495, 2179.6621523663857, 2176.706144670473, 2219.866807991518, 2222.288867562381, 2223.3885681437655, 2223.4774827915426, 2136.4872430616697, 2160.8379371547117, 2233.62028455163, 2237.899294531742, 2239.0819763896807, 1920.5870737791372, 1951.1512492065997, 2123.819475344598, 2160.8487405881597, 2187.3000639795273, 2130.3289463818846, 2131.9467013324634, 2149.183310342076, 2152.9138834446603, 2155.1810312081466, 7092.822679433004, 7132.4294056475355, 7149.53528020677, 7156.0, 7156.499045066847, 4162.729422587522, 4199.622034016923, 4205.663546916239, 4231.238377092122, 4237.87286381409, 2837.9432411351863, 2844.8008639395252, 2880.15035564509, 2882.4811533923885, 2957.45287121881, 899.1772528136747, 899.7795540092719, 912.1015799437548, 918.0865039285886, 930.418488444722, 9313.767155821091, 9395.20140788027, 9415.340926135174, 9416.717498475056, 9421.76445588859, 3837.175007373428, 3837.6354246346555, 3844.6539811417106, 3872.9612703873163, 4042.8989275268355, 8191.79520511992, 8199.508029518249, 8206.58967051645, 8209.09699933007, 8212.917870821335, 4316.676249281317, 4337.067530480962, 4339.262325404688, 4354.521002689701, 4355.651547876162, 3964.365701487748, 3964.841406343714, 3968.523777146761, 3969.3450580653866, 3972.880813575597, 3505.8422370992857, 3528.576570811519, 3529.6999755020597, 3531.399662057456, 3567.6789088981595, 1074.5809134437575, 1125.4597793059377, 1134.773045390925, 1141.2353723005606, 1146.7133216695827, 960.0879164793474, 963.4123184857232, 994.4530508220595, 1001.1190152665607, 1008.4100801031332, 6873.072135261676, 6892.0, 6900.3099690031595, 6914.101166848278, 6919.827004324831, 438.47602115471705, 441.1904155873943, 1123.6572845282103, 1148.2134737704698, 1161.9244749091451, 5449.918251226235, 5498.80754173602, 5506.807261745819, 5517.917231241535, 5522.889542209134, 8356.832863342821, 8464.576771161417, 8792.780180495538, 8893.688720894737, 8907.910920890838, 8696.347773916981, 8696.739097827076, 8818.911810881937, 8824.647014119491, 8826.691065812665, 6879.449644028466, 6893.827654308682, 6998.265182155902, 7004.859902801915, 7036.050133231948, 6688.6990085445295, 6704.564203326768, 6737.696803643946, 6751.223609284799, 6754.155730533684, 7689.346405555367, 7814.88277675824, 7837.568933708701, 7923.881141782763, 7967.641456134372, 7536.284053014955, 7769.223077692185, 7774.144844067261, 7781.37748980069, 8127.0, 6647.0, 6657.40083392497, 6665.666716664245, 6738.561993470409, 6744.022116793136, 7112.715491380493, 7116.8932466014085, 7123.572585644878, 7146.821329466805, 7155.570665760071, 6739.359760822714, 6792.76225332111, 6812.0, 6864.450843932574, 6889.552179108342, 6513.934860651522, 6677.69950352245, 6685.39831415175, 6721.798346049626, 6739.797806065826, 6568.6058836469965, 6608.801735947929, 6643.70103345341, 6644.202695676549, 6647.102641143384, 5806.158107074535, 5873.4126587340925, 5880.441358070976, 5907.3797251288, 5927.288725352985, 5997.820065398045, 6023.3374328824675, 6037.215162028908, 6038.396160383926, 6038.486728628116], "unit": "score", "name": "mootools.html", "value": 4150.408992544879}, {"lowerIsBetter": false, "replicates": [328.0764647517239, 328.8125768312062, 330.3096528255945, 333.576358025308, 339.79951828421224, 5908.852278693024, 6090.543209259306, 6094.2991555971075, 6095.817125486237, 6119.6328220306705, 5832.300123985127, 5984.162217289583, 6000.849978750533, 6016.217891674076, 6027.578069535123, 4658.138244424776, 4658.697184683002, 4659.976700116495, 4661.627069834413, 4671.92992105117, 4414.536473670267, 4464.843730469434, 4520.593146616804, 4611.400517932664, 4657.301404789292, 4576.542345765413, 4587.885302867422, 4596.2416201326905, 4598.264277715566, 4617.0, 4600.884977875547, 4603.125406172817, 4608.838690645811, 4610.193216187154, 4619.307103934403, 4051.0480037191237, 4053.7365071270274, 4054.108096218827, 4057.9594204057876, 4069.674426045909, 5672.688002159921, 5714.771409143629, 5773.134029895507, 5781.219535362714, 5801.100829371454, 5378.300820893298, 5384.623076384654, 5386.703731294777, 5392.05639013175, 5392.541633961118, 6096.4817990470865, 6377.553571250014, 6382.553221274513, 6382.808515744535, 6388.265349484822, 4372.081862808814, 4375.16871794358, 4469.709468884512, 4472.932906006413, 4502.189605870942, 6638.966805165944, 6653.900191497131, 6686.665666716644, 6697.832554186136, 6700.765473208415, 4626.653001024869, 4633.698809577367, 4633.837815676503, 4636.327732478771, 4636.35091087248, 4389.736615803062, 4471.35165401015, 4500.549945005539, 4690.108879312919, 4696.9060618787435, 5236.895262094813, 5259.737013149327, 5267.3152490176035, 5267.9736601316745, 5268.0, 6414.454771344394, 6449.451796597248, 6458.5479016469335, 6461.676916154268, 6461.8061458156335, 1587.8729701623843, 1617.3692260018602, 1617.5713435939485, 1619.4251040880554, 1620.6758648270393, 1047.1831971062584, 1056.3450660590483, 1064.489045258265, 1065.3181963543338, 1090.1278976818514, 6090.725917333731, 6104.236970378703, 6115.6330620162935, 6115.938840611626, 6124.265088189446, 6628.502862285348, 6635.037919501645, 6643.435307998874, 6644.036614690843, 6647.734090636321, 5965.880682386415, 6095.085737139465, 6097.664628445478, 6097.878042439126, 6106.328303886569, 3566.375884220251, 3597.0, 3602.1715005548344, 3604.1350075981577, 3605.7295702822394, 6852.383285504328, 6865.725370985205, 6869.656517174121, 6871.725130994704, 6875.037494750739, 6647.86704265912, 6761.560498567577, 6769.120014398195, 6778.93221067783, 6780.694868730919, 6803.591784492946, 6855.4172895304455, 6874.072000279998, 6878.896816547655, 6883.3116688330765, 6375.649339286384, 6506.967465162644, 6508.284088750328, 6611.438027767501, 6623.966880165568, 6535.085088087767, 6552.082708420729, 6598.769043083469, 6610.140681711347, 6612.801615951529, 6878.621675807879, 6911.861762764616, 6913.412359949461, 6922.169339679271, 6925.3074692530345, 4499.730016199039, 4594.173048851105, 4634.2353511671545, 4645.721256724607, 4649.209634362099, 6596.868062638816, 6600.80197594073, 6601.702923368556, 6605.306442823435, 6613.404793568409, 6422.582532135396, 6491.545591808528, 6491.772787952399, 6493.318201588765, 6496.382843629847, 6334.176557047738, 6469.029645553204, 6482.092507048923, 6537.346265373425, 6545.770898018546, 6350.872982540231, 6392.968035159794, 6401.903971440339, 6403.807885763435, 6406.967965160145, 6571.178602674666, 6582.76960306387, 6584.50616203777, 6586.814373412832, 6590.308017658077, 6250.656213908097, 6420.6468644225015, 6424.421802037839, 6424.582402143846, 6433.388828061326], "unit": "score", "name": "prototype.html", "value": 4838.759180762418}, {"lowerIsBetter": false, "replicates": [658.8484648530834, 672.8553361027379, 683.1597135523306, 769.8537277917195, 790.9802254943628, 15539.53381398557, 15692.45076422327, 15722.606934826606, 15737.0, 15754.842451575481, 14208.218547979857, 14271.143731376125, 14325.57023289303, 14330.283485825694, 14335.283235838193, 681.7818298144596, 690.0856365315951, 813.3940214540175, 813.5972693516688, 826.900771907369, 815.2866242038217, 815.5514467043132, 822.3708862719994, 822.6257053040882, 823.7899335669396, 863.7236084452977, 864.5245115186622, 867.0852250875324, 867.4925168776274, 868.8783570300131, 699.5872435263194, 712.2343480758179, 756.2513112019117, 786.8386980669006, 791.8257983243677, 573.781962854117, 575.7696921231541, 580.6719203649924, 580.7386675995776, 580.9680467574282, 13877.861221387859, 13961.371738271802, 13976.0, 13992.370343334473, 13996.30018499071, 11981.940090299493, 11996.64010079699, 12020.879791202151, 12273.079519036019, 12333.198342107824, 10109.443980581065, 10208.0, 10383.117435018032, 10465.267431279814, 10532.526036328383, 3468.1849765305133, 3543.255916257589, 3568.0, 3592.1558433768046, 3632.891013269606, 46259.30611040837, 46563.06873862538, 46800.53199467996, 46891.29663055057, 46901.76549117233, 9901.653442129491, 10026.097651211427, 10103.444310562843, 10136.391816491034, 10152.23858210637, 17399.391021314193, 17644.91177544104, 17658.11709414524, 17686.469405917844, 17723.0, 7363.300486453778, 7482.176960534337, 7489.588072655947, 7510.286522780327, 7581.962090189514, 4079.286124928126, 4102.979485102555, 4142.08874047709, 4177.6866734995, 4191.1827193697545, 2859.1994241612383, 2881.8991335303162, 2882.12095310928, 2882.3658795065053, 2883.4377296426997, 533.7758141580467, 535.4912832808848, 537.2451705353984, 538.1362912525418, 552.0366959655427, 554.4483239177044, 577.7775556410728, 583.2417856786161, 596.3678500789177, 640.6508452893185, 7414.518056326429, 7619.809504762315, 7941.841163176704, 8624.0, 9159.77100572491, 486.51105638832746, 490.08354377313935, 630.5050535329744, 637.2034956304619, 692.5740669488329, 3695.279420513028, 3746.3069332173636, 3785.432185172246, 3884.1066554692015, 3959.9604003960167, 52085.0, 52853.0, 53871.0, 57318.426815731305, 58765.0, 49484.75257623689, 49762.50237497651, 51040.0, 51217.0, 51546.22680659793, 44617.77691111524, 45170.54829451664, 45339.09321813611, 45695.08609827785, 46304.0, 7917.0, 8075.798105047421, 8088.150744172012, 8207.097219305751, 8213.342932565261, 35761.64238357583, 36273.45589816208, 36840.44739328859, 37065.81467092647, 37155.25689486249, 41861.79069104635, 41974.58025419707, 44109.55890441054, 46417.76791116023, 46824.531754682015, 11126.109911207246, 11168.776624467628, 11177.832332514856, 11340.262882912584, 11520.827187592025, 11373.090152787923, 11382.146339024772, 11571.594994175164, 11927.46326415296, 12324.753504930031, 10664.57341706354, 10773.461326933779, 10802.405867677353, 10838.566457341618, 11170.27393219438, 10994.670159895217, 11100.389478578756, 11375.886241137483, 11379.08967282632, 11751.118666100248, 10680.305780124267, 10795.73010674708, 11241.156913231376, 11252.60615878473, 11592.88407115918, 8707.0, 8870.467771933705, 8890.199882010651, 9123.680671176477, 9233.445993240428, 7633.5419874807685, 7703.422243331885, 7744.303012728881, 9191.448513089235, 9197.31020173503], "unit": "score", "name": "yui.html", "value": 6132.828176801385}], "name": "dromaeo_css", "value": 6718.185774902037}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 105.0, 110.0, 112.0, 111.0, 100.0, 110.0, 110.0, 100.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [149.0, 127.0, 144.0, 160.0, 124.0, 151.0, 152.0, 125.0, 174.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 158.0, 159.0, 161.0, 162.0, 161.0, 161.0, 159.0, 163.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 90.0, 93.0, 72.0, 70.0, 71.0, 101.0, 89.0, 74.0], "unit": "score", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 138.0, 95.0, 96.0, 95.0, 141.0, 95.0, 95.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 147.0, 147.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 67.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 85.0, 86.0, 94.0, 90.0, 85.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.4}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 119.0, 120.0, 119.0, 113.0, 133.0, 116.0, 118.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [141.0, 150.0, 150.0, 157.0, 154.0, 149.0, 160.0, 152.0, 150.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.0}, {"lowerIsBetter": true, "replicates": [76.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1505.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.84155756965424], "unit": "score", "name": "Richards", "value": 210.32931599999992}, {"lowerIsBetter": false, "replicates": [190.43991620643686], "unit": "score", "name": "DeltaBlue", "value": 347.1856180000001}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [800.640512409928], "unit": "score", "name": "Earley", "value": 832.4122870000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26230.76923076923], "unit": "score", "name": "RegExp", "value": 34.729633431085055}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19728.42209835186}]} 11:20:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19728.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1505.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6718.19"}}} 11:20:33 INFO - Return code: 0 11:20:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:20:33 INFO - # TBPL SUCCESS # 11:20:33 INFO - Running post-action listener: _resource_record_post_action 11:20:33 INFO - Running post-run listener: _resource_record_post_run 11:20:34 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553754624; Read time: 12; Write time: 487964 11:20:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244875264; Read time: 0; Write time: 272116 11:20:34 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 308879360; Read time: 12; Write time: 215848 11:20:34 INFO - Running post-run listener: _upload_blobber_files 11:20:34 INFO - Blob upload gear active. 11:20:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:20:34 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 11:20:34 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:20:34 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:20:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:35 INFO - (blobuploader) - INFO - Done attempting. 11:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:36 INFO - (blobuploader) - INFO - Done attempting. 11:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:36 INFO - Return code: 0 11:20:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c52f9c011a3663f180c05d7044aeb391f1642c1e074623003f45a511e5c5dc1b266335998a40b874a2f01666fed5b8757be3ab358637f26b58b0ed99b10de712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0e7ad9a4c7a5a30dc5d1edbf0b71153bbabb5bc421fac825b57f9e05c4424ed0f4e4a5792ae5d699314a2e126ed46064d7924ee7e479df25539cb299fafc3abf"} 11:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:20:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:20:36 INFO - Contents: 11:20:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c52f9c011a3663f180c05d7044aeb391f1642c1e074623003f45a511e5c5dc1b266335998a40b874a2f01666fed5b8757be3ab358637f26b58b0ed99b10de712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0e7ad9a4c7a5a30dc5d1edbf0b71153bbabb5bc421fac825b57f9e05c4424ed0f4e4a5792ae5d699314a2e126ed46064d7924ee7e479df25539cb299fafc3abf"} 11:20:36 INFO - Copying logs to upload dir... 11:20:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.162150 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-28 11:20:36.351658) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:20:36.357252) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c52f9c011a3663f180c05d7044aeb391f1642c1e074623003f45a511e5c5dc1b266335998a40b874a2f01666fed5b8757be3ab358637f26b58b0ed99b10de712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0e7ad9a4c7a5a30dc5d1edbf0b71153bbabb5bc421fac825b57f9e05c4424ed0f4e4a5792ae5d699314a2e126ed46064d7924ee7e479df25539cb299fafc3abf"} build_url:https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/N1rsQH7GQX2Gp9EffQSacw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/c52f9c011a3663f180c05d7044aeb391f1642c1e074623003f45a511e5c5dc1b266335998a40b874a2f01666fed5b8757be3ab358637f26b58b0ed99b10de712", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0e7ad9a4c7a5a30dc5d1edbf0b71153bbabb5bc421fac825b57f9e05c4424ed0f4e4a5792ae5d699314a2e126ed46064d7924ee7e479df25539cb299fafc3abf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-28 11:20:36.383278) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:20:36.383671) ========= 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=fce1c2174958ee92775f70ae000001a3-1451328993.838295-1926996446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 11:20:36.467231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:20:36.467576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 11:20:36.467888) ========= ========= Total master_lag: 0.26 =========