builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1450439313.65 results: success (0) buildid: 20151218013002 builduid: 5f078149d91e480fbd2d87e2d33b9368 revision: d47e90499b87c267ed261ea6762b85afde5b8a28 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.648046) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.648467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.648792) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004944 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.710329) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.710638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.776948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.777260) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.826072) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.826368) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.826753) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:33.827065) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 03:48:33-- 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% 225M=0s 2015-12-18 03:48:34 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.212585 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.051744) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.052060) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.067804 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.131643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.131988) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d47e90499b87c267ed261ea6762b85afde5b8a28 --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/mozilla-inbound --rev d47e90499b87c267ed261ea6762b85afde5b8a28 --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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 03:48:34,215 truncating revision to first 12 chars 2015-12-18 03:48:34,215 Setting DEBUG logging. 2015-12-18 03:48:34,215 attempt 1/10 2015-12-18 03:48:34,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d47e90499b87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 03:48:34,469 unpacking tar archive at: mozilla-inbound-d47e90499b87/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.704541) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.704845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.712866) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.713187) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 03:48:34.713644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-18 03:48:34.713937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:48:35 INFO - MultiFileLogger online at 20151218 03:48:35 in /builds/slave/test-pgo 03:48:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:48:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:48:35 INFO - {'append_to_log': False, 03:48:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:48:35 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:48:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:48:35 INFO - 'branch': 'Mozilla-Inbound', 03:48:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:48:35 INFO - 'config_files': ('talos/linux_config.py',), 03:48:35 INFO - 'default_actions': ('clobber', 03:48:35 INFO - 'read-buildbot-config', 03:48:35 INFO - 'download-and-extract', 03:48:35 INFO - 'populate-webroot', 03:48:35 INFO - 'create-virtualenv', 03:48:35 INFO - 'install', 03:48:35 INFO - 'run-tests'), 03:48:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:48:35 INFO - 'download_minidump_stackwalk': True, 03:48:35 INFO - 'download_symbols': 'ondemand', 03:48:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:48:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:48:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:48:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:48:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:48:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:48:35 INFO - 'installer_path': 'installer.exe', 03:48:35 INFO - 'log_level': 'info', 03:48:35 INFO - 'log_name': 'talos', 03:48:35 INFO - 'log_to_console': True, 03:48:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:48:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:48:35 INFO - 'opt_config_files': (), 03:48:35 INFO - 'pip_index': False, 03:48:35 INFO - 'sps_profile': False, 03:48:35 INFO - 'sps_profile_interval': 0, 03:48:35 INFO - 'suite': 'dromaeojs', 03:48:35 INFO - 'system_bits': '64', 03:48:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:48:35 INFO - 'title': 'talos-linux64-ix-044', 03:48:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:48:35 INFO - 'use_talos_json': True, 03:48:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:48:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:48:35 INFO - 'work_dir': 'build'} 03:48:35 INFO - ##### 03:48:35 INFO - ##### Running clobber step. 03:48:35 INFO - ##### 03:48:35 INFO - Running pre-action listener: _resource_record_pre_action 03:48:35 INFO - Running main action method: clobber 03:48:35 INFO - rmtree: /builds/slave/test-pgo/build 03:48:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:48:41 INFO - Running post-action listener: _resource_record_post_action 03:48:41 INFO - ##### 03:48:41 INFO - ##### Running read-buildbot-config step. 03:48:41 INFO - ##### 03:48:41 INFO - Running pre-action listener: _resource_record_pre_action 03:48:41 INFO - Running main action method: read_buildbot_config 03:48:41 INFO - Using buildbot properties: 03:48:41 INFO - { 03:48:41 INFO - "project": "", 03:48:41 INFO - "product": "firefox", 03:48:41 INFO - "script_repo_revision": "production", 03:48:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 03:48:41 INFO - "repository": "", 03:48:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 03:48:41 INFO - "buildid": "20151218013002", 03:48:41 INFO - "pgo_build": "True", 03:48:41 INFO - "basedir": "/builds/slave/test-pgo", 03:48:41 INFO - "buildnumber": 552, 03:48:41 INFO - "slavename": "talos-linux64-ix-044", 03:48:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:48:41 INFO - "platform": "ubuntu64_hw", 03:48:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 03:48:41 INFO - "branch": "mozilla-inbound", 03:48:41 INFO - "repo_path": "integration/mozilla-inbound", 03:48:41 INFO - "revision": "d47e90499b87c267ed261ea6762b85afde5b8a28", 03:48:41 INFO - "stage_platform": "linux64-pgo", 03:48:41 INFO - "builduid": "5f078149d91e480fbd2d87e2d33b9368", 03:48:41 INFO - "slavebuilddir": "test" 03:48:41 INFO - } 03:48:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:48:41 INFO - Running post-action listener: _resource_record_post_action 03:48:41 INFO - ##### 03:48:41 INFO - ##### Running download-and-extract step. 03:48:41 INFO - ##### 03:48:41 INFO - Running pre-action listener: _resource_record_pre_action 03:48:41 INFO - Running main action method: download_and_extract 03:48:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:41 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json 03:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json 03:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:48:41 INFO - Downloaded 1302 bytes. 03:48:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:48:41 INFO - Using the following test package requirements: 03:48:41 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:48:41 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'jsshell-linux-x86_64.zip'], 03:48:41 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:48:41 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:48:41 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:48:41 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:48:41 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:48:41 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:48:41 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:48:41 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:41 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:44 INFO - Downloaded 23121183 bytes. 03:48:44 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 03:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:44 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 03:48:45 INFO - Return code: 0 03:48:45 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 03:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:45 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:49 INFO - Downloaded 23121183 bytes. 03:48:49 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 03:48:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:48:49 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 03:48:52 INFO - Return code: 0 03:48: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')]} 03:48:52 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:48:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:54 INFO - Downloaded 11132185 bytes. 03:48:54 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 03:48:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:48:54 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 03:48:54 INFO - Return code: 0 03:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:54 INFO - https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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 03:48:56 INFO - Downloaded 54647430 bytes. 03:48:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:56 INFO - mkdir: /builds/slave/test-pgo/properties 03:48:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:48:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:48:56 INFO - Contents: 03:48:56 INFO - build_url:https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:48:56 INFO - Running post-action listener: _resource_record_post_action 03:48:56 INFO - Running post-action listener: set_extra_try_arguments 03:48:56 INFO - ##### 03:48:56 INFO - ##### Running populate-webroot step. 03:48:56 INFO - ##### 03:48:56 INFO - Running pre-action listener: _resource_record_pre_action 03:48:56 INFO - Running main action method: populate_webroot 03:48:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:48:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:48:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:48:56 INFO - '--tppagecycles', 03:48:56 INFO - '7'], 03:48:56 INFO - 'tests': ['tsvgm']}}, 03:48:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:48:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:48:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:48:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:48:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'tests': ['damp', 'tps']}, 03:48:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['damp', 'tps']}, 03:48:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:48:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:48:56 INFO - 'other': {'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'other_l64': {'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'other_nol64': {'tests': ['a11yr', 03:48:56 INFO - 'ts_paint', 03:48:56 INFO - 'tpaint', 03:48:56 INFO - 'sessionrestore', 03:48:56 INFO - 'sessionrestore_no_auto_restore']}, 03:48:56 INFO - 'svgr': {'tests': ['tsvgx', 03:48:56 INFO - 'tsvgr_opacity', 03:48:56 INFO - 'tart', 03:48:56 INFO - 'tscrollx', 03:48:56 INFO - 'cart']}, 03:48:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['tsvgx', 03:48:56 INFO - 'tsvgr_opacity', 03:48:56 INFO - 'tart', 03:48:56 INFO - 'tscrollx', 03:48:56 INFO - 'cart']}, 03:48:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'tests': ['tp5o']}, 03:48:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'talos_options': ['--e10s'], 03:48:56 INFO - 'tests': ['tp5o']}, 03:48:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'talos_options': ['--xperf_path', 03:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:56 INFO - 'tests': ['tp5n']}, 03:48:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:48:56 INFO - 'talos_options': ['--e10s', 03:48:56 INFO - '--xperf_path', 03:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:48:56 INFO - 'tests': ['tp5n']}}, 03:48:56 INFO - 'talos.zip': {'path': '', 03:48:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:48:56 INFO - Running post-action listener: _resource_record_post_action 03:48:56 INFO - ##### 03:48:56 INFO - ##### Running create-virtualenv step. 03:48:56 INFO - ##### 03:48:56 INFO - Running pre-action listener: _resource_record_pre_action 03:48:56 INFO - Running main action method: create_virtualenv 03:48:56 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:48:56 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 03:48:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:48:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:48:57 INFO - Using real prefix '/usr' 03:48:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:48:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:49:00 INFO - Installing pip.................done. 03:49:00 INFO - Return code: 0 03:49:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:49:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:49:00 INFO - Using env: {'DISPLAY': ':0', 03:49:00 INFO - 'HOME': '/home/cltbld', 03:49:00 INFO - 'LANG': 'en_US.UTF-8', 03:49:00 INFO - 'LANGUAGE': 'en_US:en', 03:49:00 INFO - 'LOGNAME': 'cltbld', 03:49:00 INFO - 'MAIL': '/var/mail/cltbld', 03:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:00 INFO - 'MOZ_NO_REMOTE': '1', 03:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:00 INFO - 'NO_EM_RESTART': '1', 03:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:00 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:00 INFO - 'SHELL': '/bin/bash', 03:49:00 INFO - 'SHLVL': '1', 03:49:00 INFO - 'TERM': 'linux', 03:49:00 INFO - 'TMOUT': '86400', 03:49:00 INFO - 'USER': 'cltbld', 03:49:00 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:00 INFO - '_': '/tools/buildbot/bin/python'} 03:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:01 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 03:49:01 INFO - Cleaning up... 03:49:01 INFO - Return code: 0 03:49:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:01 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:01 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 03:49:01 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 03:49:01 INFO - Using env: {'DISPLAY': ':0', 03:49:01 INFO - 'HOME': '/home/cltbld', 03:49:01 INFO - 'LANG': 'en_US.UTF-8', 03:49:01 INFO - 'LANGUAGE': 'en_US:en', 03:49:01 INFO - 'LOGNAME': 'cltbld', 03:49:01 INFO - 'MAIL': '/var/mail/cltbld', 03:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:01 INFO - 'MOZ_NO_REMOTE': '1', 03:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:01 INFO - 'NO_EM_RESTART': '1', 03:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:01 INFO - 'SHELL': '/bin/bash', 03:49:01 INFO - 'SHLVL': '1', 03:49:01 INFO - 'TERM': 'linux', 03:49:01 INFO - 'TMOUT': '86400', 03:49:01 INFO - 'USER': 'cltbld', 03:49:01 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:01 INFO - '_': '/tools/buildbot/bin/python'} 03:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:01 INFO - Downloading/unpacking psutil>=0.7.1 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49: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 03:49:02 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:49:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:49:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:03 INFO - Installing collected packages: psutil 03:49:03 INFO - Running setup.py install for psutil 03:49:03 INFO - building 'psutil._psutil_linux' extension 03:49:03 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 03:49:05 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 03:49:05 INFO - building 'psutil._psutil_posix' extension 03:49:05 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 03:49:05 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 03:49:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:49:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:49:05 INFO - Successfully installed psutil 03:49:05 INFO - Cleaning up... 03:49:05 INFO - Return code: 0 03:49:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:05 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:05 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 03:49:05 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 03:49:05 INFO - Using env: {'DISPLAY': ':0', 03:49:05 INFO - 'HOME': '/home/cltbld', 03:49:05 INFO - 'LANG': 'en_US.UTF-8', 03:49:05 INFO - 'LANGUAGE': 'en_US:en', 03:49:05 INFO - 'LOGNAME': 'cltbld', 03:49:05 INFO - 'MAIL': '/var/mail/cltbld', 03:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:05 INFO - 'MOZ_NO_REMOTE': '1', 03:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:05 INFO - 'NO_EM_RESTART': '1', 03:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:05 INFO - 'SHELL': '/bin/bash', 03:49:05 INFO - 'SHLVL': '1', 03:49:05 INFO - 'TERM': 'linux', 03:49:05 INFO - 'TMOUT': '86400', 03:49:05 INFO - 'USER': 'cltbld', 03:49:05 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:05 INFO - '_': '/tools/buildbot/bin/python'} 03:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:49:05 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 03:49:05 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 03:49:05 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 03:49:05 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 03:49:05 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 03:49:05 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 03:49:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:49:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:49:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:49:07 INFO - Installing collected packages: mozsystemmonitor 03:49:07 INFO - Running setup.py install for mozsystemmonitor 03:49:07 INFO - Successfully installed mozsystemmonitor 03:49:07 INFO - Cleaning up... 03:49:07 INFO - Return code: 0 03:49:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:49:07 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')]} 03:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 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')]} 03:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:07 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:07 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 03:49:07 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 03:49:07 INFO - Using env: {'DISPLAY': ':0', 03:49:07 INFO - 'HOME': '/home/cltbld', 03:49:07 INFO - 'LANG': 'en_US.UTF-8', 03:49:07 INFO - 'LANGUAGE': 'en_US:en', 03:49:07 INFO - 'LOGNAME': 'cltbld', 03:49:07 INFO - 'MAIL': '/var/mail/cltbld', 03:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:07 INFO - 'MOZ_NO_REMOTE': '1', 03:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:07 INFO - 'NO_EM_RESTART': '1', 03:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:07 INFO - 'SHELL': '/bin/bash', 03:49:07 INFO - 'SHLVL': '1', 03:49:07 INFO - 'TERM': 'linux', 03:49:07 INFO - 'TMOUT': '86400', 03:49:07 INFO - 'USER': 'cltbld', 03:49:07 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:07 INFO - '_': '/tools/buildbot/bin/python'} 03:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:08 INFO - Downloading/unpacking blobuploader==1.2.4 03:49:08 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 03:49:08 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 03:49:08 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 03:49:08 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 03:49:08 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 03:49:08 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 03:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:49:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:49:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:49:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:09 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 03:49:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:49:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:10 INFO - Downloading docopt-0.6.1.tar.gz 03:49:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:49:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:49:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:49:10 INFO - Running setup.py install for blobuploader 03:49:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:49:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:49:10 INFO - Running setup.py install for requests 03:49:10 INFO - Running setup.py install for docopt 03:49:11 INFO - Successfully installed blobuploader requests docopt 03:49:11 INFO - Cleaning up... 03:49:11 INFO - Return code: 0 03:49:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:11 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')]} 03:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 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')]} 03:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:11 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:11 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 03:49:11 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 03:49:11 INFO - Using env: {'DISPLAY': ':0', 03:49:11 INFO - 'HOME': '/home/cltbld', 03:49:11 INFO - 'LANG': 'en_US.UTF-8', 03:49:11 INFO - 'LANGUAGE': 'en_US:en', 03:49:11 INFO - 'LOGNAME': 'cltbld', 03:49:11 INFO - 'MAIL': '/var/mail/cltbld', 03:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:11 INFO - 'MOZ_NO_REMOTE': '1', 03:49:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:11 INFO - 'NO_EM_RESTART': '1', 03:49:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:11 INFO - 'SHELL': '/bin/bash', 03:49:11 INFO - 'SHLVL': '1', 03:49:11 INFO - 'TERM': 'linux', 03:49:11 INFO - 'TMOUT': '86400', 03:49:11 INFO - 'USER': 'cltbld', 03:49:11 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:11 INFO - '_': '/tools/buildbot/bin/python'} 03:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:11 INFO - Running setup.py (path:/tmp/pip-6TV608-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:11 INFO - Running setup.py (path:/tmp/pip-EMPGqW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:11 INFO - Running setup.py (path:/tmp/pip-okpcON-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:11 INFO - Running setup.py (path:/tmp/pip-eQiK0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:11 INFO - Running setup.py (path:/tmp/pip-cFugjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:11 INFO - Running setup.py (path:/tmp/pip-UUsuFO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:11 INFO - Running setup.py (path:/tmp/pip-_ctsEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:11 INFO - Running setup.py (path:/tmp/pip-Ftu4qY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:11 INFO - Running setup.py (path:/tmp/pip-i85xjq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:11 INFO - Running setup.py (path:/tmp/pip-ZzB3gj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:12 INFO - Running setup.py (path:/tmp/pip-fdw_9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:12 INFO - Running setup.py (path:/tmp/pip-cmtKw6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:12 INFO - Running setup.py (path:/tmp/pip-awPhHC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:12 INFO - Running setup.py (path:/tmp/pip-EQZyMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:12 INFO - Running setup.py (path:/tmp/pip-YsxAZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:12 INFO - Running setup.py (path:/tmp/pip-P_PThB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:12 INFO - Running setup.py (path:/tmp/pip-Elaj8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:49:12 INFO - Running setup.py install for manifestparser 03:49:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:49:12 INFO - Running setup.py install for mozcrash 03:49:12 INFO - Running setup.py install for mozdebug 03:49:12 INFO - Running setup.py install for mozdevice 03:49:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:49:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:49:12 INFO - Running setup.py install for mozfile 03:49:13 INFO - Running setup.py install for mozhttpd 03:49:13 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozinfo 03:49:13 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozInstall 03:49:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozleak 03:49:13 INFO - Running setup.py install for mozlog 03:49:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for moznetwork 03:49:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozprocess 03:49:13 INFO - Running setup.py install for mozprofile 03:49:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozrunner 03:49:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:49:13 INFO - Running setup.py install for mozscreenshot 03:49:14 INFO - Running setup.py install for moztest 03:49:14 INFO - Running setup.py install for mozversion 03:49:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:49:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:49:14 INFO - Cleaning up... 03:49:14 INFO - Return code: 0 03:49:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:14 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:14 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 03:49:14 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 03:49:14 INFO - Using env: {'DISPLAY': ':0', 03:49:14 INFO - 'HOME': '/home/cltbld', 03:49:14 INFO - 'LANG': 'en_US.UTF-8', 03:49:14 INFO - 'LANGUAGE': 'en_US:en', 03:49:14 INFO - 'LOGNAME': 'cltbld', 03:49:14 INFO - 'MAIL': '/var/mail/cltbld', 03:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:14 INFO - 'MOZ_NO_REMOTE': '1', 03:49:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:14 INFO - 'NO_EM_RESTART': '1', 03:49:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:14 INFO - 'SHELL': '/bin/bash', 03:49:14 INFO - 'SHLVL': '1', 03:49:14 INFO - 'TERM': 'linux', 03:49:14 INFO - 'TMOUT': '86400', 03:49:14 INFO - 'USER': 'cltbld', 03:49:14 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:14 INFO - '_': '/tools/buildbot/bin/python'} 03:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:14 INFO - Running setup.py (path:/tmp/pip-HTUq67-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:14 INFO - Running setup.py (path:/tmp/pip-ZQREPF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:14 INFO - Running setup.py (path:/tmp/pip-kQxLvl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:14 INFO - Running setup.py (path:/tmp/pip-Pb7J64-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:14 INFO - Running setup.py (path:/tmp/pip-lbOdMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:14 INFO - Running setup.py (path:/tmp/pip-a3V88Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:49:14 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)) 03:49:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:14 INFO - Running setup.py (path:/tmp/pip-qp6T2m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:15 INFO - Running setup.py (path:/tmp/pip-f1coRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:15 INFO - Running setup.py (path:/tmp/pip-mZKR8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:15 INFO - Running setup.py (path:/tmp/pip-X7fuCp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:15 INFO - Running setup.py (path:/tmp/pip-wYtcLD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:15 INFO - Running setup.py (path:/tmp/pip-d9DdtA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:15 INFO - Running setup.py (path:/tmp/pip-psjzLi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:15 INFO - Running setup.py (path:/tmp/pip-cZS829-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:15 INFO - Running setup.py (path:/tmp/pip-2S370I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:15 INFO - Running setup.py (path:/tmp/pip-u9rTmA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:49:15 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)) 03:49:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:15 INFO - Running setup.py (path:/tmp/pip-LYq1gI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:49:15 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)) 03:49:15 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)) 03:49:15 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)) 03:49:15 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)) 03:49:15 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)) 03:49:15 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)) 03:49:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:17 INFO - Downloading blessings-1.5.1.tar.gz 03:49:17 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 03:49:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:49:17 INFO - Installing collected packages: blessings 03:49:17 INFO - Running setup.py install for blessings 03:49:17 INFO - Successfully installed blessings 03:49:17 INFO - Cleaning up... 03:49:17 INFO - Return code: 0 03:49:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:49:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:17 INFO - Reading from file tmpfile_stdout 03:49:17 INFO - Current package versions: 03:49:17 INFO - argparse == 1.2.1 03:49:17 INFO - blessings == 1.5.1 03:49:17 INFO - blobuploader == 1.2.4 03:49:17 INFO - docopt == 0.6.1 03:49:17 INFO - manifestparser == 1.1 03:49:17 INFO - mozInstall == 1.12 03:49:17 INFO - mozcrash == 0.16 03:49:17 INFO - mozdebug == 0.1 03:49:17 INFO - mozdevice == 0.47 03:49:17 INFO - mozfile == 1.2 03:49:17 INFO - mozhttpd == 0.7 03:49:17 INFO - mozinfo == 0.9 03:49:17 INFO - mozleak == 0.1 03:49:17 INFO - mozlog == 3.1 03:49:17 INFO - moznetwork == 0.27 03:49:17 INFO - mozprocess == 0.22 03:49:17 INFO - mozprofile == 0.27 03:49:17 INFO - mozrunner == 6.11 03:49:17 INFO - mozscreenshot == 0.1 03:49:17 INFO - mozsystemmonitor == 0.0 03:49:17 INFO - moztest == 0.7 03:49:17 INFO - mozversion == 1.4 03:49:17 INFO - psutil == 3.1.1 03:49:17 INFO - requests == 1.2.3 03:49:17 INFO - wsgiref == 0.1.2 03:49:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:17 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:17 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 03:49:17 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 03:49:17 INFO - Using env: {'DISPLAY': ':0', 03:49:17 INFO - 'HOME': '/home/cltbld', 03:49:17 INFO - 'LANG': 'en_US.UTF-8', 03:49:17 INFO - 'LANGUAGE': 'en_US:en', 03:49:17 INFO - 'LOGNAME': 'cltbld', 03:49:17 INFO - 'MAIL': '/var/mail/cltbld', 03:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:17 INFO - 'MOZ_NO_REMOTE': '1', 03:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:17 INFO - 'NO_EM_RESTART': '1', 03:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:17 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:17 INFO - 'SHELL': '/bin/bash', 03:49:17 INFO - 'SHLVL': '1', 03:49:17 INFO - 'TERM': 'linux', 03:49:17 INFO - 'TMOUT': '86400', 03:49:17 INFO - 'USER': 'cltbld', 03:49:17 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:17 INFO - '_': '/tools/buildbot/bin/python'} 03:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 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)) 03:49:18 INFO - Cleaning up... 03:49:18 INFO - Return code: 0 03:49:18 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:49:18 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')]} 03:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 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')]} 03:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:18 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:18 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 03:49:18 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 03:49:18 INFO - Using env: {'DISPLAY': ':0', 03:49:18 INFO - 'HOME': '/home/cltbld', 03:49:18 INFO - 'LANG': 'en_US.UTF-8', 03:49:18 INFO - 'LANGUAGE': 'en_US:en', 03:49:18 INFO - 'LOGNAME': 'cltbld', 03:49:18 INFO - 'MAIL': '/var/mail/cltbld', 03:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:18 INFO - 'MOZ_NO_REMOTE': '1', 03:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:18 INFO - 'NO_EM_RESTART': '1', 03:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:18 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:18 INFO - 'SHELL': '/bin/bash', 03:49:18 INFO - 'SHLVL': '1', 03:49:18 INFO - 'TERM': 'linux', 03:49:18 INFO - 'TMOUT': '86400', 03:49:18 INFO - 'USER': 'cltbld', 03:49:18 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:18 INFO - '_': '/tools/buildbot/bin/python'} 03:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:18 INFO - Downloading/unpacking jsonschema 03:49:18 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 03:49:18 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 03:49:18 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 03:49:18 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 03:49:18 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 03:49:18 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 03:49:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:49:20 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 03:49:20 INFO - Downloading/unpacking functools32 (from jsonschema) 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:49:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:49:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:49:20 INFO - warning: no files found matching '*.txt' 03:49:20 INFO - no previously-included directories found matching 'build' 03:49:20 INFO - no previously-included directories found matching 'dist' 03:49:20 INFO - no previously-included directories found matching '.git*' 03:49:20 INFO - Installing collected packages: jsonschema, functools32 03:49:20 INFO - Running setup.py install for functools32 03:49:20 INFO - warning: no files found matching '*.txt' 03:49:20 INFO - no previously-included directories found matching 'build' 03:49:20 INFO - no previously-included directories found matching 'dist' 03:49:20 INFO - no previously-included directories found matching '.git*' 03:49:20 INFO - Successfully installed jsonschema functools32 03:49:20 INFO - Cleaning up... 03:49:20 INFO - Return code: 0 03:49:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:49:20 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 0x7f005abe0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f528a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201f360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, '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': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', '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 03:49:20 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 03:49:20 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 03:49:20 INFO - Using env: {'DISPLAY': ':0', 03:49:20 INFO - 'HOME': '/home/cltbld', 03:49:20 INFO - 'LANG': 'en_US.UTF-8', 03:49:20 INFO - 'LANGUAGE': 'en_US:en', 03:49:20 INFO - 'LOGNAME': 'cltbld', 03:49:20 INFO - 'MAIL': '/var/mail/cltbld', 03:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:20 INFO - 'MOZ_NO_REMOTE': '1', 03:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:20 INFO - 'NO_EM_RESTART': '1', 03:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:20 INFO - 'SHELL': '/bin/bash', 03:49:20 INFO - 'SHLVL': '1', 03:49:20 INFO - 'TERM': 'linux', 03:49:20 INFO - 'TMOUT': '86400', 03:49:20 INFO - 'USER': 'cltbld', 03:49:20 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:20 INFO - '_': '/tools/buildbot/bin/python'} 03:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:49:20 INFO - Downloading/unpacking flake8 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:20 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 03:49:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:49:22 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 03:49:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:49:22 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 03:49:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 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 03:49:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:49:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:49:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:49:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:23 INFO - no previously-included directories found matching 'docs/_build' 03:49:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:49:23 INFO - Running setup.py install for pep8 03:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:49:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:49:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:49:23 INFO - no previously-included directories found matching 'docs/_build' 03:49:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:49:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:49:23 INFO - Cleaning up... 03:49:23 INFO - Return code: 0 03:49:23 INFO - Running post-action listener: _resource_record_post_action 03:49:23 INFO - Running post-action listener: _start_resource_monitoring 03:49:23 INFO - Starting resource monitoring. 03:49:23 INFO - ##### 03:49:23 INFO - ##### Running install step. 03:49:23 INFO - ##### 03:49:23 INFO - Running pre-action listener: _resource_record_pre_action 03:49:23 INFO - Running main action method: install 03:49:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:49:23 INFO - Reading from file tmpfile_stdout 03:49:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:49:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:49:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:49:23 INFO - Reading from file tmpfile_stdout 03:49:23 INFO - Output received: 03:49:23 INFO - Usage: mozinstall [options] installer 03:49:23 INFO - Options: 03:49:23 INFO - -h, --help show this help message and exit 03:49:23 INFO - -d DEST, --destination=DEST 03:49:23 INFO - Directory to install application into. [default: 03:49:23 INFO - "/builds/slave/test-pgo"] 03:49:23 INFO - --app=APP Application being installed. [default: firefox] 03:49:23 INFO - mkdir: /builds/slave/test-pgo/build/application 03:49:23 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'] 03:49:23 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 03:49:39 INFO - Reading from file tmpfile_stdout 03:49:39 INFO - Output received: 03:49:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:49:39 INFO - Running post-action listener: _resource_record_post_action 03:49:39 INFO - ##### 03:49:39 INFO - ##### Running run-tests step. 03:49:39 INFO - ##### 03:49:39 INFO - Running pre-action listener: _resource_record_pre_action 03:49:39 INFO - Running main action method: run_tests 03:49:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:49:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:49:39 INFO - Python 2.7.3 03:49:39 INFO - Return code: 0 03:49:39 INFO - grabbing minidump binary from tooltool 03:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:49:39 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 0x20ae540>, '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 0x20af440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20af8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:49:39 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 03:49:39 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 03:49:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:49:39 INFO - Return code: 0 03:49:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:49:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:49:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:49:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:49:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:49:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:49:40 INFO - Return code: 0 03:49:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 03:49:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 03:49:40 INFO - Using env: {'DISPLAY': ':0', 03:49:40 INFO - 'HOME': '/home/cltbld', 03:49:40 INFO - 'LANG': 'en_US.UTF-8', 03:49:40 INFO - 'LANGUAGE': 'en_US:en', 03:49:40 INFO - 'LOGNAME': 'cltbld', 03:49:40 INFO - 'MAIL': '/var/mail/cltbld', 03:49:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:49:40 INFO - 'MOZ_NO_REMOTE': '1', 03:49:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:49:40 INFO - 'NO_EM_RESTART': '1', 03:49:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:49:40 INFO - 'PWD': '/builds/slave/test-pgo', 03:49:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:49:40 INFO - 'SHELL': '/bin/bash', 03:49:40 INFO - 'SHLVL': '1', 03:49:40 INFO - 'TERM': 'linux', 03:49:40 INFO - 'TMOUT': '86400', 03:49:40 INFO - 'USER': 'cltbld', 03:49:40 INFO - 'XDG_SESSION_COOKIE': '0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676', 03:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:49:40 INFO - '_': '/tools/buildbot/bin/python'} 03:49:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:49:41 INFO - mozversion application_buildid: 20151218013002 03:49:41 INFO - mozversion application_changeset: d47e90499b87c267ed261ea6762b85afde5b8a28 03:49:41 INFO - mozversion application_display_name: Nightly 03:49:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:49:41 INFO - mozversion application_name: Firefox 03:49:41 INFO - mozversion application_remotingname: firefox 03:49:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:41 INFO - mozversion application_vendor: Mozilla 03:49:41 INFO - mozversion application_version: 46.0a1 03:49:41 INFO - mozversion platform_buildid: 20151218013002 03:49:41 INFO - mozversion platform_changeset: d47e90499b87c267ed261ea6762b85afde5b8a28 03:49:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:49:41 INFO - mozversion platform_version: 46.0a1 03:49:41 INFO - using testdate: 1450439381 03:49:41 INFO - actual date: 1450439381 03:49:41 INFO - starting webserver on 'localhost:45431' 03:49:41 INFO - SUITE-START | Running 3 tests 03:49:41 INFO - TEST-START | dromaeo_css 03:49:41 INFO - operating with platform_type : linux_ 03:49:41 INFO - Initialising browser for dromaeo_css test... 03:49:41 INFO - TEST-INFO | started process 3407 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJuBZv/profile http://localhost:45431/getInfo.html) 03:49:47 INFO - PROCESS | 3407 | __metrics Screen width/height:1600/1200 03:49:47 INFO - PROCESS | 3407 | colorDepth:24 03:49:47 INFO - PROCESS | 3407 | Browser inner width/height: 1024/697 03:49:47 INFO - PROCESS | 3407 | __metrics 03:49:47 INFO - PROCESS | 3407 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 03:49:47 INFO - PROCESS | 3407 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:47 ERROR - PROCESS | 3407 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:49:48 INFO - TEST-INFO | 3407: exit 0 03:49:48 INFO - Browser initialized. 03:49:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:49:48 INFO - TEST-INFO | started process 3502 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSJuBZv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:00 INFO - PROCESS | 3502 | RSS: Main: 149422080 03:50:00 INFO - PROCESS | 3502 | 03:50:51 INFO - PROCESS | 3502 | 1450439451388 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] 03:53:01 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45431/tests/dromaeo/cssquery-ext.html) 03:53:02 INFO - PROCESS | 3502 | RSS: Main: 240713728 03:53:02 INFO - PROCESS | 3502 | 03:56:04 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-ext.html (next: http://localhost:45431/tests/dromaeo/cssquery-jquery.html) 03:56:05 INFO - PROCESS | 3502 | RSS: Main: 225906688 03:56:05 INFO - PROCESS | 3502 | 03:59:07 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45431/tests/dromaeo/cssquery-mootools.html) 03:59:07 INFO - PROCESS | 3502 | RSS: Main: 221499392 03:59:07 INFO - PROCESS | 3502 | 04:02:09 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45431/tests/dromaeo/cssquery-prototype.html) 04:02:10 INFO - PROCESS | 3502 | RSS: Main: 212819968 04:02:10 INFO - PROCESS | 3502 | 04:05:12 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45431/tests/dromaeo/cssquery-yui.html) 04:05:13 INFO - PROCESS | 3502 | RSS: Main: 216342528 04:05:13 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | Cycle 1(1): loaded http://localhost:45431/tests/dromaeo/cssquery-yui.html (next: http://localhost:45431/tests/dromaeo/cssquery-dojo.html) 04:08:15 INFO - PROCESS | 3502 | RSS: Main: 262090752 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | __start_tp_report 04:08:15 INFO - PROCESS | 3502 | _x_x_mozilla_page_load 04:08:15 INFO - PROCESS | 3502 | _x_x_mozilla_page_load_details 04:08:15 INFO - PROCESS | 3502 | |i|pagename|runs| 04:08:15 INFO - PROCESS | 3502 | |0;dojo.html;3110.7355874750647;3145.6382516010635;3178.1577881861294;3181.7772755907095;3192.1859925718936;5129.589632829374;5191.766370513326;5210.8697282567955;5311.973440132799;5338.359396872376;5273.551748101416;5325.440828712987;5326.627136100475;5356.143017117262;5487.314085739283;4814.6870453420415;4858.514148585131;4876.049170411762;4973.229149481836;4982.800687972477;4914.483979182188;4930.137225985456;4966.379202599675;4981.750912454381;5057.772400241998;4650.906981860361;4744.57298843104;4754.120487709784;4869.70781753096;4877.804887804484;4841.540053694894;4917.852464426073;4924.039812236615;4946.604271658259;4947.183714687072;4848.878778030542;4874.951250487486;4904.337914381548;4919.7540122993705;4956.826511072131;4993;5087.542121209109;5120.359955005624;5199.454057323965;5213.661112027706;5653.660780353192;5657.20799088128;5659.264295641581;5669.943300567024;5675.34733505648;5661.037623603997;5667.971660141673;5671.602987790856;5675.63108397957;5678.801241956553;5266.104762190437;5363.141897296453;5368.516833485005;5369.060414427459;5454.809081682122;5850;6001.4298641628975;6017.398260174035;6020.57855950088;6021.337652858182;5734.741936612862;5785.855353616109;5786.797462088806;5787.797427090031;5834.154047663065;5471.124620060771;5566.693831839288;5601.467860553241;5649.830505084854;5857.20927674767;5662.065759149694;5805.970970145207;5843.707814609253;5844.88310233793;5846.532277417797;5807.506361959281;5845.240118784531;5851.707414629252;5857.092150716646;5861.238039054981;4324.502682191588;4403.471583410012;4403.581659742319;4407.801648925806;4501.954980450219;3928.901777455529;3976.880693579197;4021.557628660845;4079.4288799568085;4100.405441211008;5390.676559406448;5392.4607539246545;5394.460553944574;5395.379531353866;5409.107497262908;5696.430356964271;5746.511546518593;5750.884982300414;5750.913736293959;5795.391483894215;5179.300794392709;5293.920591191135;5302.549283310962;5385;5505.421930697299;4991.925121123186;5019.372578427697;5020.974895125574;5033.219850923113;5036.143855544567;5801.970990145107;5844.649321040752;5862.032764593794;5876.44173803488;5906.7637294508595;5665.575081868794;5759.193712880284;5767.336756273083;5790.826275211751;5793.826185214451;5894.233749612523;5951.077582974646;6047.606905551125;6064.211652485149;6071.666058366833;5810.070388737781;5821.155932389865;5821.650700957956;5822.970885145547;5828.300603927386;5557.444255574572;5863.882722345615;5899.557533185114;5904.940950590439;5905.91141132892;5655.462731040545;5684.857878553069;5697.373288938296;5748.252727145612;5803.535717142534;5672.5461963042035;5676.4323567642905;5684.914726279027;5698.544116470755;5700.002499562477;5278.445763194809;5576.358718747234;5591.245181900392;5600.467955544217;5607.523360514238;5450.400455949763;5464.672119672673;5670.858228544154;5795.594308398372;5797.449242321973;5581.7209139543675;5620.718964051863;5627.5497960162265;5629.746661400165;5669.6314739541795 04:08:15 INFO - PROCESS | 3502 | |1;ext.html;557.4425574425575;583.4398976982097;592.3602509289966;604.1330690459192;609.1471939284997;29416.411671766553;37432.43851342232;37774.24451510975;37935.24129517408;37977.620223797756;41446.378304325386;41871.37192942108;41924;42019;42056;7486.513376630529;7619.1238007629;8728.869066963985;8907.287417006624;8911.465312081264;10391.116755075827;10618.893811061867;10627.681169564925;10631.255812093157;10634.840477392845;10170.38977661339;10285.742856428575;10290.176785857113;10291.125254353388;10345.275830691817;7623.618819059025;7750.534967901944;10127.189824813997;10128.64549740763;10461.581536738522;10018.749531261705;10132.898671013269;10154.339967902062;10210.795784084277;10261.230407719451;38129.618703812885;38626.42060369097;38651.420228696596;38664;38712.419313710314;3236.4983427568527;3252.317013427183;3295.8846440374473;3404.3191361727504;3550.0592343029116;29471.85264073666;29523.409531809244;29582.70417295821;29618.25954351137;30040;3517.0503963929596;3562.6615471530163;3586.7668601540818;3633.8728144514816;3668.724845636588;257743;259188;259196;259454;259600;53902.46097539053;54475.72762136164;54485.72757136189;54634;54635.180472292945;56584.71707641435;58066.4193358061;59761.701191494634;59928.40071599316;60998;14423.206723630092;14593.78109328361;14693.26533673312;14698.11811291326;14704.705905881823;10859.891401086046;10889.292196007234;10907.618233361953;11002.119830413547;11031.062359699356;19392.4182274532;19724.802751972584;19730.112144953513;19730.40808775739;19785.40643780689;7448.813779655552;7585.886211706828;7694.615269236628;7711.344535714415;7788;890.0387581412059;948.7390967483997;1004.8492726090999;1015.243643485608;1032.3547782635853;24545.38636534065;26262.6060609091;26539.203823885313;26666.333341666614;26732.59901101485;979.7844474215804;988.081084591337;1042.1402343067;1076.9983914959164;1109.2235435195234;13624.591262262147;13989.580312590639;14014.71970560583;14092.154470731788;14170.149791012573;328492;329506;330634;331589;331914;50455;50613;50662;50688.98622027539;50806.49193508018;1176.5411489519095;1193.659806955031;1253.2793643654934;1299.7790375636164;1306.3076569418224;25358.87320563459;26391.868040659672;26447.73552264453;26471.73528264693;26505.734942650328;42592.14815703731;43002.569974299855;43027.784861075495;43053.78473107614;43165.78417107894;303848;305486;305903;306463;306782;27531.44937101287;27902.3024424391;29381.26546836346;30993.69006309998;31416.37167256688;39651.60348396479;39947.2010559793;40031.39952900651;40645.39031914583;40832;33511;33621.83189084137;33821.83089084539;34605.653943460246;35153.47269790904;27622.171334859988;33046.83476582602;33918.83040584781;34095.82952085323;34171.82914085513;27636.58545121865;33268;34138.31723365568;34202.65797341995;34665;27215.45569088647;30088.09735707932;31308.843455782575;32250.35499290048;32334;22733.204337848096;23330.300090997298;23932.52134957326;23968.76031239665;24394.26817195487 04:08:15 INFO - PROCESS | 3502 | |2;jquery.html;359.6547314578005;362.0405924300605;365.3496775739184;366.8679275460834;367.96320367963204;13472.730545389086;13514.72970540591;16249.43126990554;16312.91843540782;16908.32366705332;14260.714785704306;14624.195669238188;16864;17123.22945467454;17560.473185804414;5391.81128660496;5503.504684578387;5512.448755124476;5513.228148059255;5517.36550296717;4006.1186538961383;4096.97951510242;5246.816361427351;5427.213054107152;5434.049041417736;5869.178315035899;5977.521798256129;5993.430624090704;6037.003894357425;6038.667873266991;5822.3886491918165;5949.791757288474;5955.047192449188;5962.314333851597;5982.730777115018;5229.477052294778;5250.5274525292525;5256.106461901486;5259.421463638997;5260.526552610245;19534.80465195344;20006.299779507648;20018.399448016437;20839.16643334265;21152.153913843427;1978.9010549472468;2310.2145270608075;2379.89290481927;2393.533261014103;2456.5086982603552;9278.628854845798;9563.139317461393;9563.665271715527;10531.368117912873;13050.15174013686;1778.7065134252832;1780.9910950445164;1794.4257837492007;1826.0960824392012;1826.196473551633;59104.40895591075;61507.38492615106;61895.690521547556;62312.37687623111;62424;9550.331476796557;9576.808463830685;9765.853512197322;9770.26722995778;9873.111419972238;12316.445759940823;12356.505739770308;12405.069619778553;12414;12415.379231038592;7132.572045677276;7252.419806415474;7289.157228680819;7323.707051717978;7352.228016058344;6956.443484521226;7001.684924178322;7061.752838650726;7167.677454514559;7185.53294035886;4009.7770180094767;4027.4160246764054;4172.374143878443;4231.703780735319;4271.893202669896;1657.839512341366;1699.1589163363967;1726.620143568413;1728.2395745871777;1761.9911900440416;854.3763052971242;896.4979611417627;911.3256190419042;953.3374304858196;986.5609803637456;15808.36766529349;15929.203539822962;16443.506694799176;16816.159192040595;17027.233774480177;777.708359365238;902.5036230073565;906.2251774732508;920.921721653667;926.0600490502146;9614.759631009281;9715.46564938935;9818.410895346302;9835.901640983642;9861.161801246973;493434;493815;496195;517385;521630;72017.27982720106;78251.2174878244;80035;81240.59379703182;81613;1045.4563626913962;1067.6423398161548;1069.0859315285475;1086.8532748078908;1111.0944580166977;15311.693766124838;15414.229288535304;15473.922630386776;15576.92211538935;15872.92063539675;31437.842810786715;32172.678273217905;32473;36309.63690363063;37144.07139821526;36276;36800.815995919846;43385.566144338154;45056.324155137045;45614.54385456103;9111.271098311987;9382.29632777558;9387.671431499864;9866.654667086617;9935.552900119368;17604.559886002953;17698.380556680968;17952.730709039115;17973.64052718912;18073.728894066335;14404.20776857241;14668.55994320172;14848.109113453227;14852.183129927958;15179.468718594797;14027.088239264414;14354.49759258421;14397.784033239719;14701.92649036748;14818.184999825113;11468.942655287005;11735.119866010255;14295;14552.27238638085;14998.550043498712;7854.4894581851995;7863.84272314562;8039.557824319719;9420.95289523548;9601.47191904452;10102.646407375707;10267.486625668836;11254.437278135896;14331.641708956942;14689.045212061183 04:08:15 INFO - PROCESS | 3502 | |3;mootools.html;1397.5946975377142;1478.3495262084684;1530.4260902161689;1582.6834633073381;1714.0915314883116;6774.4241739452145;7295.452841036924;7430.851382972337;7452.5901075440825;7457.477976541631;7502.36229920456;7568;7635.732749353774;7641.388688904888;7644.044494438195;1912.3402426162952;1954.4332143678387;2192.4957259830207;2248.280550223929;2251.3583628665833;2136.2629892687078;2181.9526627218943;2182.3671135370723;2183.5851188274255;2183.6396994495967;2126.5853158634072;2151.397608669575;2233.4974630708125;2233.8547994380397;2234.8323875709307;2148.9140434382607;2160.038782741665;2168.533765240473;2187.3437968609355;2190.7809219078126;2177.4447515883508;2201.97608112227;2202.4603972026794;2203;2204.1183526589334;7235.638218089074;7251.5286506376915;7291.052163218747;7308.707651693926;7313.195548489662;4394.209042372372;4495.23580991229;4499.61753250974;4500.909981800379;4504.774761261924;2936.765058795291;2957.467655821951;3016.306249562591;3016.834074125922;3034.1656044587694;1024.3085917006065;1033.364480844283;1056.8573242612304;1068.8931106889327;1069.7432616172064;10024.248181386425;10194.796104077877;10198.694039178836;10202.846957295647;10256.128229100535;4070.6946978976102;4074.8573799916862;4145.875623731293;4161.25097482456;4163.5836416358125;8831.69089081879;8839.29285657146;8880.289576833839;8882.200601945726;8886.37795354319;4635.907281854344;4639.466461356919;4642.930356044662;4643.419572553431;4645.0477652081245;4171.958280417218;4229.851955181553;4244.702870799015;4247.936280955788;4265.104328091135;3290.8683652654104;3349.4138525757894;3517.9648203517636;3655.9634403656155;3742.8128593570214;1173.202222488699;1186.2822992089834;1187.6199616122758;1189.7679952409371;1198.670365649436;1007;1007.7279134633754;1063.5586231713753;1119.5577746789972;1283.5507572349602;6984.301569842975;7007.264237255014;7083.5041547091205;7094.574325540484;7102.644867756591;1160.2168536238005;1164.7845148647527;1191.803352446854;1217.0993464836135;1221.183800623053;5533.584981126432;5557.777688892399;5569.610127291051;5573.888522229533;5607.327120745536;8650.78373040679;8772.78068048304;8823.647054117764;8852.601632926533;8873.423227490193;8693.521856297837;8775.385722999328;8778.561071946377;8782.780430489289;8788.516631585324;6905.965470172617;6992.999999999898;7018.964905175441;7021;7056.894146587805;7024.5434046786795;7056.929430705627;7069.222385537484;7078.893816592652;7078.929210707827;7813.218678132369;7955.403344749051;8156.632951517077;8174.509529428254;8175.345972322319;8113.634886430007;8137.6744930204495;8195.139510351328;8213.630386632496;8236.464629799044;6525.543211975116;6639.634820084942;6650.933490665031;6653.401193892573;6661.633610151294;6401.071844582416;6518.250401203923;6787.253402125861;6944.4444444445335;7076.71693132269;6686.933130668631;6701.966490167518;6782.593044417351;6823.624700641512;6850.21222559412;6578.24350199714;6628.53600247978;6647.667616619053;6749.5612785168805;6754.729810807513;6545.607263564201;6550;6553.2136143663065;6557.770478033246;6574.539782215199;6201.96899015502;6210.472109870711;6245.0632405139595;6276.246850377984;6278.434940855345;6179.320274769681;6223.066540019034;6306.590071645328;6313.842153946188;6314.810555683337 04:08:15 INFO - PROCESS | 3502 | |4;prototype.html;318.20448877805484;325.3184578308443;326.7059646318313;327.7787493441927;331.5606820962226;5874.2950845898495;5920.674362910038;5935.495482883949;5957.6127551709105;5976.52187824974;5621.381648018714;5680.630759000662;5738.3974682658245;5818.883622327551;5826.766929322822;4522.253828118356;4533.387992620987;4536.160810250114;4540.364348991127;4547.272436410167;4326.826926922935;4540.2054640437955;4541.45502539694;4543.568361005699;4552.749598772066;4371.14762621289;4388.363687265344;4469.82120715171;4473.172463094322;4474.284114541674;4437.4009508716235;4441.600255976961;4445.1331990261915;4458.264386376244;4464.084862603158;3903.8048097595292;3906.8827935161708;3907.4529565860803;3909.843606255746;3913.6086391360923;5456.072467680504;5562.749676264578;5567.3040869891265;5567.66594004361;5569.10894256917;5235.869103272411;5240.3187585614005;5244.292020577212;5246.580273578104;5250.3962044364625;6169;6175.44421002112;6191.442770150708;6191.752329906798;6200.3799620037635;4366.759828209447;4367.301231802896;4372.060007098489;4373.300271956472;4388.188185185719;6334.778282760081;6445.452136568398;6467.967660161716;6489.772857949996;6491.8052458425855;4483.327500874895;4491.663125265618;4495.348174514677;4502.212112880233;4507.549245075466;4534.36518887356;4543.091381723669;4543.522930092358;4549.749763763025;4566.70316429431;5225.3207083079715;5229.738513074407;5245.580353571705;5252.080885844962;5252.1596544552685;6148.200733904564;6256.155419018374;6260.812175634738;6275.090111933744;6282.591631543935;1596.6806638672313;1615.055192712253;1618.1828176770655;1619.3117924882113;1620.5786495511252;1081.2539347849959;1094.195766111907;1097.1223021582703;1102.1293178388983;1111.4498323330004;5988.071848863433;5998.280206375263;5998.340182579913;6079.574429789961;6086.02623580225;6420.101185833987;6475.902861457082;6478.125453063776;6479.384458476437;6483.902741458882;5842.415758424208;5916.1421593868645;5966.463018328372;5981.790637327673;5982.282126144803;3435.4159792835276;3535.0101971448034;3544.113971507123;3546.1666508370513;3548.7693299935936;6690.698918548677;6691.899621505681;6695.799126026227;6696.363845434676;6708.631025293558;6681.9331806682285;6687.832804179837;6689.297623749533;6690.799276021728;6695.497837662195;6535.0850880876715;6712.2616512184595;6715.764948226789;6733.595984240863;6755.459563234929;6547.770828020996;6551.312112228147;6557.540972131905;6562.146920900444;6567.014947757874;6356.936430635635;6463.062855885776;6480.287168411565;6483.967580162069;6487.935120648922;6687.264400915798;6706.8993965089585;6713.664316784044;6714.362135597111;6719.496037797087;4403.669724770591;4440.7335559866515;4451.10977804434;4452.465704115527;4453.465584129795;6530.183727034121;6536.379043990813;6550.377714117151;6565.606063636197;6568.967155164193;6252.812415627538;6270.2475702915945;6341.0805433212845;6371.04434334835;6377.330380310001;6297.244330680164;6350.555461117678;6352.555321127476;6352.555321127476;6355.682215889279;6240.594361366497;6245.0632405139595;6248.968755156195;6252;6252.187215661935;6259.654174352536;6385.042243663488;6390.265119511316;6398.5521013528605;6402.6158430494315;6234.594751341148;6239.282482514569;6240.7503699851495;6241.21984751906;6250.812475625738 04:08:15 INFO - PROCESS | 3502 | |5;yui.html;721.4372789224403;750.4784174998376;821.5235163605109;832.8209434971479;839.7396806989832;11702.531898724052;11940.761184776311;11978.580749673763;11989.820152697717;11990.40047997601;11790.4694288757;11828.112891533148;11839.881601183986;11949.163558550905;11954;662.3608218069573;676.8950812624051;677.6882633988371;678.199724325296;787.6494959742917;803.907550631679;811.2982270336146;818.5088946632033;823.4482896459386;827.5613924619961;838.9035260944978;854.9230569248766;856.1310270075878;856.1395797223781;856.2251162697769;698.5145323999848;706.1420374245316;830.9542975136366;848.6266042941086;856.028407757197;609.5123900879323;614.7940439952621;623.7598524568028;624.1729708136737;624.7657128576784;12304.200226985307;12596.433160507799;12698.492060317576;12699;12717.682057948625;11408.315501069963;11673.416329183592;11881.94059029708;12636.11547191697;13220.206787592775;9951.203903687687;10023.74940626483;10057.798844023151;10101.797964040752;10137.594496220143;3633.7274704397278;3644.1982763791925;3648.343298206348;3675.8713445029293;3781.3004594149897;46049.76975115136;46305.30542041872;46635.76682116568;46851;47731.28403073957;9815.656452024288;10022.670325736774;10169.644062457779;10231.846522302172;10345.844812327821;18794.90602547006;18843.528911777314;18863.96248206362;18871.716924246146;18877.33929312495;7102.254263302382;7129.429645628337;7220.855582888418;7349.154847192534;7545;4080.6939479539155;4176.352665336878;4202.41166236721;4213.957860421357;4215.093754842662;2869.827810331345;2895;2896.898608548691;2897.608822808894;2938.030449951511;516.3055690096813;521.7652056574557;529.3912001198576;532.0370130064596;540.7890922540213;599.5593238969354;601.4076135007015;606.5299392970484;622.7135517661926;650.9967450162719;8346.248837604524;9018.409776225964;9291.48896810682;9339.159475647088;9430.622775089058;673.6732684647942;677.3091446724313;691.8692914561649;704.4505285877024;710.4174576846935;3880.941785873214;3985.720999530005;4046.4132700758814;4148.771817550064;4152.91694166115;57675.13487297694;57791.422085778606;58237.70881145567;58455;58548.121778173365;51594;51887.48112518902;53293.46706532885;53557.464425356025;53692;45116;46189.76905115453;46319;46506.767466162455;48380;7914.44598878073;8232.34141268709;8405.831883362422;8474.374136611465;8873.955630221808;33561;33719.49420758642;34089.318213635095;35153.47269790904;35385;43546.34680479859;45290.773546132055;45882.311765324215;46113;46412.767936160104;10031.849522257025;10128.113596700172;10194.541245644112;10732.517036733521;11292.887071129513;11388.202825802446;11888.76222475563;11907.106966977684;12150.513979440724;12273.754524909273;10699.090577300705;10749.516271767632;11007.339559626447;11044.613438529614;11117.166212534254;10606.522706478381;10717.654886150376;10956.452177390938;10966;10994.34033957965;7449.92550074514;10367.94816025915;10554.419506926886;10794.190435717195;10877.184211184034;9225.630974760934;9490;9715.805683886141;9873.25950553697;9942.105210531086;9025.909740902507;9289.814203716023;9332.72001839946;9473.384230025027;9532.714018579454 04:08:15 INFO - PROCESS | 3502 | __end_tp_report 04:08:15 INFO - PROCESS | 3502 | __start_cc_report 04:08:15 INFO - PROCESS | 3502 | _x_x_mozilla_cycle_collect,1000 04:08:15 INFO - PROCESS | 3502 | __end_cc_report 04:08:15 INFO - PROCESS | 3502 | __startTimestamp1450440495956__endTimestamp 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | ------- Summary: start ------- 04:08:15 INFO - PROCESS | 3502 | Number of tests: 6 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#0] dojo.html Cycles:165 Average:5347.69 Median:5581.72 stddev:606.11 (10.9%) stddev-sans-first:582.01 04:08:15 INFO - PROCESS | 3502 | Values: 3110.7 3145.6 3178.2 3181.8 3192.2 5129.6 5191.8 5210.9 5312.0 5338.4 5273.6 5325.4 5326.6 5356.1 5487.3 4814.7 4858.5 4876.0 4973.2 4982.8 4914.5 4930.1 4966.4 4981.8 5057.8 4650.9 4744.6 4754.1 4869.7 4877.8 4841.5 4917.9 4924.0 4946.6 4947.2 4848.9 4875.0 4904.3 4919.8 4956.8 4993.0 5087.5 5120.4 5199.5 5213.7 5653.7 5657.2 5659.3 5669.9 5675.3 5661.0 5668.0 5671.6 5675.6 5678.8 5266.1 5363.1 5368.5 5369.1 5454.8 5850.0 6001.4 6017.4 6020.6 6021.3 5734.7 5785.9 5786.8 5787.8 5834.2 5471.1 5566.7 5601.5 5649.8 5857.2 5662.1 5806.0 5843.7 5844.9 5846.5 5807.5 5845.2 5851.7 5857.1 5861.2 4324.5 4403.5 4403.6 4407.8 4502.0 3928.9 3976.9 4021.6 4079.4 4100.4 5390.7 5392.5 5394.5 5395.4 5409.1 5696.4 5746.5 5750.9 5750.9 5795.4 5179.3 5293.9 5302.5 5385.0 5505.4 4991.9 5019.4 5021.0 5033.2 5036.1 5802.0 5844.6 5862.0 5876.4 5906.8 5665.6 5759.2 5767.3 5790.8 5793.8 5894.2 5951.1 6047.6 6064.2 6071.7 5810.1 5821.2 5821.7 5823.0 5828.3 5557.4 5863.9 5899.6 5904.9 5905.9 5655.5 5684.9 5697.4 5748.3 5803.5 5672.5 5676.4 5684.9 5698.5 5700.0 5278.4 5576.4 5591.2 5600.5 5607.5 5450.4 5464.7 5670.9 5795.6 5797.4 5581.7 5620.7 5627.5 5629.7 5669.6 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#1] ext.html Cycles:180 Average:45847.60 Median:32292.18 stddev:78484.08 (243.0%) stddev-sans-first:78630.59 04:08:15 INFO - PROCESS | 3502 | Values: 557.4 583.4 592.4 604.1 609.1 29416.4 37432.4 37774.2 37935.2 37977.6 41446.4 41871.4 41924.0 42019.0 42056.0 7486.5 7619.1 8728.9 8907.3 8911.5 10391.1 10618.9 10627.7 10631.3 10634.8 10170.4 10285.7 10290.2 10291.1 10345.3 7623.6 7750.5 10127.2 10128.6 10461.6 10018.7 10132.9 10154.3 10210.8 10261.2 38129.6 38626.4 38651.4 38664.0 38712.4 3236.5 3252.3 3295.9 3404.3 3550.1 29471.9 29523.4 29582.7 29618.3 30040.0 3517.1 3562.7 3586.8 3633.9 3668.7 257743.0 259188.0 259196.0 259454.0 259600.0 53902.5 54475.7 54485.7 54634.0 54635.2 56584.7 58066.4 59761.7 59928.4 60998.0 14423.2 14593.8 14693.3 14698.1 14704.7 10859.9 10889.3 10907.6 11002.1 11031.1 19392.4 19724.8 19730.1 19730.4 19785.4 7448.8 7585.9 7694.6 7711.3 7788.0 890.0 948.7 1004.8 1015.2 1032.4 24545.4 26262.6 26539.2 26666.3 26732.6 979.8 988.1 1042.1 1077.0 1109.2 13624.6 13989.6 14014.7 14092.2 14170.1 328492.0 329506.0 330634.0 331589.0 331914.0 50455.0 50613.0 50662.0 50689.0 50806.5 1176.5 1193.7 1253.3 1299.8 1306.3 25358.9 26391.9 26447.7 26471.7 26505.7 42592.1 43002.6 43027.8 43053.8 43165.8 303848.0 305486.0 305903.0 306463.0 306782.0 27531.4 27902.3 29381.3 30993.7 31416.4 39651.6 39947.2 40031.4 40645.4 40832.0 33511.0 33621.8 33821.8 34605.7 35153.5 27622.2 33046.8 33918.8 34095.8 34171.8 27636.6 33268.0 34138.3 34202.7 34665.0 27215.5 30088.1 31308.8 32250.4 32334.0 22733.2 23330.3 23932.5 23968.8 24394.3 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#2] jquery.html Cycles:180 Average:27543.91 Median:4018.60 stddev:82492.39 (2052.8%) stddev-sans-first:82698.54 04:08:15 INFO - PROCESS | 3502 | Values: 359.7 362.0 365.3 366.9 368.0 13472.7 13514.7 16249.4 16312.9 16908.3 14260.7 14624.2 16864.0 17123.2 17560.5 5391.8 5503.5 5512.4 5513.2 5517.4 4006.1 4097.0 5246.8 5427.2 5434.0 5869.2 5977.5 5993.4 6037.0 6038.7 5822.4 5949.8 5955.0 5962.3 5982.7 5229.5 5250.5 5256.1 5259.4 5260.5 19534.8 20006.3 20018.4 20839.2 21152.2 1978.9 2310.2 2379.9 2393.5 2456.5 9278.6 9563.1 9563.7 10531.4 13050.2 1778.7 1781.0 1794.4 1826.1 1826.2 59104.4 61507.4 61895.7 62312.4 62424.0 9550.3 9576.8 9765.9 9770.3 9873.1 12316.4 12356.5 12405.1 12414.0 12415.4 7132.6 7252.4 7289.2 7323.7 7352.2 6956.4 7001.7 7061.8 7167.7 7185.5 4009.8 4027.4 4172.4 4231.7 4271.9 1657.8 1699.2 1726.6 1728.2 1762.0 854.4 896.5 911.3 953.3 986.6 15808.4 15929.2 16443.5 16816.2 17027.2 777.7 902.5 906.2 920.9 926.1 9614.8 9715.5 9818.4 9835.9 9861.2 493434.0 493815.0 496195.0 517385.0 521630.0 72017.3 78251.2 80035.0 81240.6 81613.0 1045.5 1067.6 1069.1 1086.9 1111.1 15311.7 15414.2 15473.9 15576.9 15872.9 31437.8 32172.7 32473.0 36309.6 37144.1 36276.0 36800.8 43385.6 45056.3 45614.5 9111.3 9382.3 9387.7 9866.7 9935.6 17604.6 17698.4 17952.7 17973.6 18073.7 14404.2 14668.6 14848.1 14852.2 15179.5 14027.1 14354.5 14397.8 14701.9 14818.2 11468.9 11735.1 14295.0 14552.3 14998.6 7854.5 7863.8 8039.6 9421.0 9601.5 10102.6 10267.5 11254.4 14331.6 14689.0 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#3] mootools.html Cycles:180 Average:5234.73 Median:6190.64 stddev:2669.18 (43.1%) stddev-sans-first:2661.08 04:08:15 INFO - PROCESS | 3502 | Values: 1397.6 1478.3 1530.4 1582.7 1714.1 6774.4 7295.5 7430.9 7452.6 7457.5 7502.4 7568.0 7635.7 7641.4 7644.0 1912.3 1954.4 2192.5 2248.3 2251.4 2136.3 2182.0 2182.4 2183.6 2183.6 2126.6 2151.4 2233.5 2233.9 2234.8 2148.9 2160.0 2168.5 2187.3 2190.8 2177.4 2202.0 2202.5 2203.0 2204.1 7235.6 7251.5 7291.1 7308.7 7313.2 4394.2 4495.2 4499.6 4500.9 4504.8 2936.8 2957.5 3016.3 3016.8 3034.2 1024.3 1033.4 1056.9 1068.9 1069.7 10024.2 10194.8 10198.7 10202.8 10256.1 4070.7 4074.9 4145.9 4161.3 4163.6 8831.7 8839.3 8880.3 8882.2 8886.4 4635.9 4639.5 4642.9 4643.4 4645.0 4172.0 4229.9 4244.7 4247.9 4265.1 3290.9 3349.4 3518.0 3656.0 3742.8 1173.2 1186.3 1187.6 1189.8 1198.7 1007.0 1007.7 1063.6 1119.6 1283.6 6984.3 7007.3 7083.5 7094.6 7102.6 1160.2 1164.8 1191.8 1217.1 1221.2 5533.6 5557.8 5569.6 5573.9 5607.3 8650.8 8772.8 8823.6 8852.6 8873.4 8693.5 8775.4 8778.6 8782.8 8788.5 6906.0 6993.0 7019.0 7021.0 7056.9 7024.5 7056.9 7069.2 7078.9 7078.9 7813.2 7955.4 8156.6 8174.5 8175.3 8113.6 8137.7 8195.1 8213.6 8236.5 6525.5 6639.6 6650.9 6653.4 6661.6 6401.1 6518.3 6787.3 6944.4 7076.7 6686.9 6702.0 6782.6 6823.6 6850.2 6578.2 6628.5 6647.7 6749.6 6754.7 6545.6 6550.0 6553.2 6557.8 6574.5 6202.0 6210.5 6245.1 6276.2 6278.4 6179.3 6223.1 6306.6 6313.8 6314.8 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#4] prototype.html Cycles:180 Average:5253.44 Median:5962.04 stddev:1584.16 (26.6%) stddev-sans-first:1544.69 04:08:15 INFO - PROCESS | 3502 | Values: 318.2 325.3 326.7 327.8 331.6 5874.3 5920.7 5935.5 5957.6 5976.5 5621.4 5680.6 5738.4 5818.9 5826.8 4522.3 4533.4 4536.2 4540.4 4547.3 4326.8 4540.2 4541.5 4543.6 4552.7 4371.1 4388.4 4469.8 4473.2 4474.3 4437.4 4441.6 4445.1 4458.3 4464.1 3903.8 3906.9 3907.5 3909.8 3913.6 5456.1 5562.7 5567.3 5567.7 5569.1 5235.9 5240.3 5244.3 5246.6 5250.4 6169.0 6175.4 6191.4 6191.8 6200.4 4366.8 4367.3 4372.1 4373.3 4388.2 6334.8 6445.5 6468.0 6489.8 6491.8 4483.3 4491.7 4495.3 4502.2 4507.5 4534.4 4543.1 4543.5 4549.7 4566.7 5225.3 5229.7 5245.6 5252.1 5252.2 6148.2 6256.2 6260.8 6275.1 6282.6 1596.7 1615.1 1618.2 1619.3 1620.6 1081.3 1094.2 1097.1 1102.1 1111.4 5988.1 5998.3 5998.3 6079.6 6086.0 6420.1 6475.9 6478.1 6479.4 6483.9 5842.4 5916.1 5966.5 5981.8 5982.3 3435.4 3535.0 3544.1 3546.2 3548.8 6690.7 6691.9 6695.8 6696.4 6708.6 6681.9 6687.8 6689.3 6690.8 6695.5 6535.1 6712.3 6715.8 6733.6 6755.5 6547.8 6551.3 6557.5 6562.1 6567.0 6356.9 6463.1 6480.3 6484.0 6487.9 6687.3 6706.9 6713.7 6714.4 6719.5 4403.7 4440.7 4451.1 4452.5 4453.5 6530.2 6536.4 6550.4 6565.6 6569.0 6252.8 6270.2 6341.1 6371.0 6377.3 6297.2 6350.6 6352.6 6352.6 6355.7 6240.6 6245.1 6249.0 6252.0 6252.2 6259.7 6385.0 6390.3 6398.6 6402.6 6234.6 6239.3 6240.8 6241.2 6250.8 04:08:15 INFO - PROCESS | 3502 | 04:08:15 INFO - PROCESS | 3502 | [#5] yui.html Cycles:180 Average:13629.67 Median:46365.88 stddev:16086.66 (34.7%) stddev-sans-first:16102.58 04:08:15 INFO - PROCESS | 3502 | Values: 721.4 750.5 821.5 832.8 839.7 11702.5 11940.8 11978.6 11989.8 11990.4 11790.5 11828.1 11839.9 11949.2 11954.0 662.4 676.9 677.7 678.2 787.6 803.9 811.3 818.5 823.4 827.6 838.9 854.9 856.1 856.1 856.2 698.5 706.1 831.0 848.6 856.0 609.5 614.8 623.8 624.2 624.8 12304.2 12596.4 12698.5 12699.0 12717.7 11408.3 11673.4 11881.9 12636.1 13220.2 9951.2 10023.7 10057.8 10101.8 10137.6 3633.7 3644.2 3648.3 3675.9 3781.3 46049.8 46305.3 46635.8 46851.0 47731.3 9815.7 10022.7 10169.6 10231.8 10345.8 18794.9 18843.5 18864.0 18871.7 18877.3 7102.3 7129.4 7220.9 7349.2 7545.0 4080.7 4176.4 4202.4 4214.0 4215.1 2869.8 2895.0 2896.9 2897.6 2938.0 516.3 521.8 529.4 532.0 540.8 599.6 601.4 606.5 622.7 651.0 8346.2 9018.4 9291.5 9339.2 9430.6 673.7 677.3 691.9 704.5 710.4 3880.9 3985.7 4046.4 4148.8 4152.9 57675.1 57791.4 58237.7 58455.0 58548.1 51594.0 51887.5 53293.5 53557.5 53692.0 45116.0 46189.8 46319.0 46506.8 48380.0 7914.4 8232.3 8405.8 8474.4 8874.0 33561.0 33719.5 34089.3 35153.5 35385.0 43546.3 45290.8 45882.3 46113.0 46412.8 10031.8 10128.1 10194.5 10732.5 11292.9 11388.2 11888.8 11907.1 12150.5 12273.8 10699.1 10749.5 11007.3 11044.6 11117.2 10606.5 10717.7 10956.5 10966.0 10994.3 7449.9 10367.9 10554.4 10794.2 10877.2 9225.6 9490.0 9715.8 9873.3 9942.1 9025.9 9289.8 9332.7 9473.4 9532.7 04:08:15 INFO - PROCESS | 3502 | -------- Summary: end -------- 04:08:15 INFO - PROCESS | 3502 | 04:08:16 INFO - TEST-INFO | 3502: exit 0 04:08:16 INFO - TEST-OK | dromaeo_css | took 1115570ms 04:08:16 INFO - TEST-START | kraken 04:08:16 INFO - operating with platform_type : linux_ 04:08:16 INFO - Initialising browser for kraken test... 04:08:16 INFO - TEST-INFO | started process 3694 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI2J0Pr/profile http://localhost:45431/getInfo.html) 04:08:21 INFO - PROCESS | 3694 | __metrics Screen width/height:1600/1200 04:08:21 INFO - PROCESS | 3694 | colorDepth:24 04:08:21 INFO - PROCESS | 3694 | Browser inner width/height: 1024/697 04:08:21 INFO - PROCESS | 3694 | __metrics 04:08:21 INFO - PROCESS | 3694 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:08:21 INFO - PROCESS | 3694 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:22 INFO - TEST-INFO | 3694: exit 0 04:08:22 INFO - Browser initialized. 04:08:22 INFO - Running cycle 1/1 for kraken test... 04:08:22 INFO - TEST-INFO | started process 3774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI2J0Pr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:08:34 INFO - PROCESS | 3774 | RSS: Main: 149876736 04:08:34 INFO - PROCESS | 3774 | 04:08:36 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-beat-detection) 04:08:37 INFO - PROCESS | 3774 | RSS: Main: 186699776 04:08:37 INFO - PROCESS | 3774 | 04:08:39 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-dft) 04:08:40 INFO - PROCESS | 3774 | RSS: Main: 177266688 04:08:40 INFO - PROCESS | 3774 | 04:08:43 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-fft) 04:08:43 INFO - PROCESS | 3774 | RSS: Main: 160194560 04:08:43 INFO - PROCESS | 3774 | 04:08:45 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45431/tests/kraken/driver.html?testName=audio-oscillator) 04:08:46 INFO - PROCESS | 3774 | RSS: Main: 163299328 04:08:46 INFO - PROCESS | 3774 | 04:08:48 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:08:49 INFO - PROCESS | 3774 | RSS: Main: 163921920 04:08:49 INFO - PROCESS | 3774 | 04:08:51 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-darkroom) 04:08:52 INFO - PROCESS | 3774 | RSS: Main: 165629952 04:08:52 INFO - PROCESS | 3774 | 04:08:55 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45431/tests/kraken/driver.html?testName=imaging-desaturate) 04:08:56 INFO - PROCESS | 3774 | RSS: Main: 165588992 04:08:56 INFO - PROCESS | 3774 | 04:08:59 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45431/tests/kraken/driver.html?testName=json-parse-financial) 04:08:59 INFO - PROCESS | 3774 | RSS: Main: 165240832 04:08:59 INFO - PROCESS | 3774 | 04:09:01 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:09:01 INFO - PROCESS | 3774 | RSS: Main: 176443392 04:09:01 INFO - PROCESS | 3774 | 04:09:03 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:09:04 INFO - PROCESS | 3774 | RSS: Main: 174051328 04:09:04 INFO - PROCESS | 3774 | 04:09:06 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:09:06 INFO - PROCESS | 3774 | RSS: Main: 183681024 04:09:06 INFO - PROCESS | 3774 | 04:09:09 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:09:09 INFO - PROCESS | 3774 | RSS: Main: 192253952 04:09:09 INFO - PROCESS | 3774 | 04:09:12 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:09:13 INFO - PROCESS | 3774 | RSS: Main: 189861888 04:09:13 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:45431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45431/tests/kraken/driver.html?testName=ai-astar) 04:09:14 INFO - PROCESS | 3774 | RSS: Main: 247779328 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | __start_tp_report 04:09:14 INFO - PROCESS | 3774 | _x_x_mozilla_page_load 04:09:14 INFO - PROCESS | 3774 | _x_x_mozilla_page_load_details 04:09:14 INFO - PROCESS | 3774 | |i|pagename|runs| 04:09:14 INFO - PROCESS | 3774 | |0;ai-astar;108;110;105;109;111;110;98;109;112;116 04:09:14 INFO - PROCESS | 3774 | |1;audio-beat-detection;148;123;149;162;133;147;149;125;160;122 04:09:14 INFO - PROCESS | 3774 | |2;audio-dft;162;160;160;159;159;160;160;163;159;162 04:09:14 INFO - PROCESS | 3774 | |3;audio-fft;71;71;84;97;71;71;72;110;87;72 04:09:14 INFO - PROCESS | 3774 | |4;audio-oscillator;94;94;141;94;94;93;145;93;93;145 04:09:14 INFO - PROCESS | 3774 | |5;imaging-gaussian-blur;111;111;110;110;109;110;110;110;110;109 04:09:14 INFO - PROCESS | 3774 | |6;imaging-darkroom;145;146;145;147;146;145;145;146;145;145 04:09:14 INFO - PROCESS | 3774 | |7;imaging-desaturate;96;96;96;95;96;96;96;97;97;97 04:09:14 INFO - PROCESS | 3774 | |8;json-parse-financial;58;58;58;57;59;57;57;67;56;56 04:09:14 INFO - PROCESS | 3774 | |9;json-stringify-tinderbox;66;67;67;66;67;72;66;67;66;67 04:09:14 INFO - PROCESS | 3774 | |10;stanford-crypto-aes;83;86;84;83;86;84;84;84;85;84 04:09:14 INFO - PROCESS | 3774 | |11;stanford-crypto-ccm;117;115;130;118;127;115;122;122;114;117 04:09:14 INFO - PROCESS | 3774 | |12;stanford-crypto-pbkdf2;149;158;149;151;150;147;153;155;150;145 04:09:14 INFO - PROCESS | 3774 | |13;stanford-crypto-sha256-iterative;66;66;65;67;66;67;65;66;66;66 04:09:14 INFO - PROCESS | 3774 | __end_tp_report 04:09:14 INFO - PROCESS | 3774 | __start_cc_report 04:09:14 INFO - PROCESS | 3774 | _x_x_mozilla_cycle_collect,927 04:09:14 INFO - PROCESS | 3774 | __end_cc_report 04:09:14 INFO - PROCESS | 3774 | __startTimestamp1450440554959__endTimestamp 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | ------- Summary: start ------- 04:09:14 INFO - PROCESS | 3774 | Number of tests: 14 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.50 stddev:4.73 (4.3%) stddev-sans-first:5.01 04:09:14 INFO - PROCESS | 3774 | Values: 108.0 110.0 105.0 109.0 111.0 110.0 98.0 109.0 112.0 116.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.50 stddev:14.96 (10.1%) stddev-sans-first:15.70 04:09:14 INFO - PROCESS | 3774 | Values: 148.0 123.0 149.0 162.0 133.0 147.0 149.0 125.0 160.0 122.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.43 (0.9%) stddev-sans-first:1.39 04:09:14 INFO - PROCESS | 3774 | Values: 162.0 160.0 160.0 159.0 159.0 160.0 160.0 163.0 159.0 162.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#3] audio-fft Cycles:10 Average:80.60 Median:72.00 stddev:13.75 (19.1%) stddev-sans-first:14.14 04:09:14 INFO - PROCESS | 3774 | Values: 71.0 71.0 84.0 97.0 71.0 71.0 72.0 110.0 87.0 72.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.50 stddev:24.23 (25.9%) stddev-sans-first:25.11 04:09:14 INFO - PROCESS | 3774 | Values: 94.0 94.0 141.0 94.0 94.0 93.0 145.0 93.0 93.0 145.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:09:14 INFO - PROCESS | 3774 | Values: 111.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:09:14 INFO - PROCESS | 3774 | Values: 145.0 146.0 145.0 147.0 146.0 145.0 145.0 146.0 145.0 145.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:09:14 INFO - PROCESS | 3774 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 97.0 97.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:58.00 stddev:3.20 (5.5%) stddev-sans-first:3.39 04:09:14 INFO - PROCESS | 3774 | Values: 58.0 58.0 58.0 57.0 59.0 57.0 57.0 67.0 56.0 56.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.86 04:09:14 INFO - PROCESS | 3774 | Values: 66.0 67.0 67.0 66.0 67.0 72.0 66.0 67.0 66.0 67.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:84.00 stddev:1.06 (1.3%) stddev-sans-first:1.01 04:09:14 INFO - PROCESS | 3774 | Values: 83.0 86.0 84.0 83.0 86.0 84.0 84.0 84.0 85.0 84.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:5.42 (4.5%) stddev-sans-first:5.66 04:09:14 INFO - PROCESS | 3774 | Values: 117.0 115.0 130.0 118.0 127.0 115.0 122.0 122.0 114.0 117.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:150.50 stddev:3.80 (2.5%) stddev-sans-first:3.98 04:09:14 INFO - PROCESS | 3774 | Values: 149.0 158.0 149.0 151.0 150.0 147.0 153.0 155.0 150.0 145.0 04:09:14 INFO - PROCESS | 3774 | 04:09:14 INFO - PROCESS | 3774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:09:14 INFO - PROCESS | 3774 | Values: 66.0 66.0 65.0 67.0 66.0 67.0 65.0 66.0 66.0 66.0 04:09:14 INFO - PROCESS | 3774 | -------- Summary: end -------- 04:09:14 INFO - PROCESS | 3774 | 04:09:15 INFO - TEST-INFO | 3774: exit 0 04:09:15 INFO - TEST-OK | kraken | took 59141ms 04:09:15 INFO - TEST-START | v8_7 04:09:15 INFO - operating with platform_type : linux_ 04:09:15 INFO - Initialising browser for v8_7 test... 04:09:15 INFO - TEST-INFO | started process 4022 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYcSpe/profile http://localhost:45431/getInfo.html) 04:09:19 INFO - PROCESS | 4022 | __metrics Screen width/height:1600/1200 04:09:19 INFO - PROCESS | 4022 | colorDepth:24 04:09:19 INFO - PROCESS | 4022 | Browser inner width/height: 1024/697 04:09:19 INFO - PROCESS | 4022 | __metrics 04:09:20 INFO - PROCESS | 4022 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:09:20 INFO - PROCESS | 4022 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:21 INFO - TEST-INFO | 4022: exit 0 04:09:21 INFO - Browser initialized. 04:09:21 INFO - Running cycle 1/1 for v8_7 test... 04:09:21 INFO - TEST-INFO | started process 4103 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpLYcSpe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:33 INFO - PROCESS | 4103 | RSS: Main: 150200320 04:09:33 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:45431/tests/v8_7/run.html (next: http://localhost:45431/tests/v8_7/run.html) 04:09:54 INFO - PROCESS | 4103 | RSS: Main: 175955968 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | __start_tp_report 04:09:54 INFO - PROCESS | 4103 | _x_x_mozilla_page_load 04:09:54 INFO - PROCESS | 4103 | _x_x_mozilla_page_load_details 04:09:54 INFO - PROCESS | 4103 | |i|pagename|runs| 04:09:54 INFO - PROCESS | 4103 | |0;Richards;165.8649859014762 04:09:54 INFO - PROCESS | 4103 | |1;DeltaBlue;190.00570017100512 04:09:54 INFO - PROCESS | 4103 | |2;Encrypt;280.58361391694723 04:09:54 INFO - PROCESS | 4103 | |3;Decrypt;5191.709844559586 04:09:54 INFO - PROCESS | 4103 | |4;RayTrace;2066.115702479339 04:09:54 INFO - PROCESS | 4103 | |5;Earley;767.638036809816 04:09:54 INFO - PROCESS | 4103 | |6;Boyer;12180.722891566265 04:09:54 INFO - PROCESS | 4103 | |7;RegExp;25025 04:09:54 INFO - PROCESS | 4103 | |8;Splay;549.7526113249038 04:09:54 INFO - PROCESS | 4103 | |9;NavierStokes;4826.923076923077 04:09:54 INFO - PROCESS | 4103 | __end_tp_report 04:09:54 INFO - PROCESS | 4103 | __startTimestamp1450440594796__endTimestamp 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | ------- Summary: start ------- 04:09:54 INFO - PROCESS | 4103 | Number of tests: 10 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 165.9 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#1] DeltaBlue Cycles:1 Average:190.01 Median:190.01 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 190.0 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 280.6 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 5191.7 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#4] RayTrace Cycles:1 Average:2066.12 Median:2066.12 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 2066.1 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#5] Earley Cycles:1 Average:767.64 Median:767.64 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 767.6 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 12180.7 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 25025.0 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#8] Splay Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 549.8 04:09:54 INFO - PROCESS | 4103 | 04:09:54 INFO - PROCESS | 4103 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:09:54 INFO - PROCESS | 4103 | Values: 4826.9 04:09:54 INFO - PROCESS | 4103 | -------- Summary: end -------- 04:09:54 INFO - PROCESS | 4103 | 04:09:55 INFO - TEST-INFO | 4103: exit 0 04:09:55 INFO - TEST-OK | v8_7 | took 39808ms 04:09:55 INFO - SUITE-END | took 1214s 04:09:55 INFO - Completed test suite (00:20:14) 04:09:55 INFO - Working with test: dromaeo_css 04:09:55 INFO - Generating results file: dromaeo_css 04:09:55 INFO - Working with test: kraken 04:09:55 INFO - Generating results file: kraken 04:09:55 INFO - javascript benchmark 04:09:55 INFO - Working with test: v8_7 04:09:55 INFO - Generating results file: v8_7 04:09:55 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 04:09:55 INFO - process_Request line: dromaeo_css 6871.52 graph.html#tests=[[72,63,35]] 04:09:55 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:55 INFO - process_Request line: kraken 1498.00 graph.html#tests=[[232,63,35]] 04:09:55 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:09:55 INFO - process_Request line: v8_7 20060.53 graph.html#tests=[[230,63,35]] 04:09:55 INFO - RETURN: dromaeo_css: 6871.52 04:09:55 INFO - RETURN: kraken: 1498.00 04:09:55 INFO - RETURN: v8_7: 20060.53 04:09:55 INFO - javascript benchmark 04:09:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3110.7355874750647, 3145.6382516010635, 3178.1577881861294, 3181.7772755907095, 3192.1859925718936, 5129.589632829374, 5191.766370513326, 5210.8697282567955, 5311.973440132799, 5338.359396872376, 5273.551748101416, 5325.440828712987, 5326.627136100475, 5356.143017117262, 5487.314085739283, 4814.6870453420415, 4858.514148585131, 4876.049170411762, 4973.229149481836, 4982.800687972477, 4914.483979182188, 4930.137225985456, 4966.379202599675, 4981.750912454381, 5057.772400241998, 4650.906981860361, 4744.57298843104, 4754.120487709784, 4869.70781753096, 4877.804887804484, 4841.540053694894, 4917.852464426073, 4924.039812236615, 4946.604271658259, 4947.183714687072, 4848.878778030542, 4874.951250487486, 4904.337914381548, 4919.7540122993705, 4956.826511072131, 4993.0, 5087.542121209109, 5120.359955005624, 5199.454057323965, 5213.661112027706, 5653.660780353192, 5657.20799088128, 5659.264295641581, 5669.943300567024, 5675.34733505648, 5661.037623603997, 5667.971660141673, 5671.602987790856, 5675.63108397957, 5678.801241956553, 5266.104762190437, 5363.141897296453, 5368.516833485005, 5369.060414427459, 5454.809081682122, 5850.0, 6001.4298641628975, 6017.398260174035, 6020.57855950088, 6021.337652858182, 5734.741936612862, 5785.855353616109, 5786.797462088806, 5787.797427090031, 5834.154047663065, 5471.124620060771, 5566.693831839288, 5601.467860553241, 5649.830505084854, 5857.20927674767, 5662.065759149694, 5805.970970145207, 5843.707814609253, 5844.88310233793, 5846.532277417797, 5807.506361959281, 5845.240118784531, 5851.707414629252, 5857.092150716646, 5861.238039054981, 4324.502682191588, 4403.471583410012, 4403.581659742319, 4407.801648925806, 4501.954980450219, 3928.901777455529, 3976.880693579197, 4021.557628660845, 4079.4288799568085, 4100.405441211008, 5390.676559406448, 5392.4607539246545, 5394.460553944574, 5395.379531353866, 5409.107497262908, 5696.430356964271, 5746.511546518593, 5750.884982300414, 5750.913736293959, 5795.391483894215, 5179.300794392709, 5293.920591191135, 5302.549283310962, 5385.0, 5505.421930697299, 4991.925121123186, 5019.372578427697, 5020.974895125574, 5033.219850923113, 5036.143855544567, 5801.970990145107, 5844.649321040752, 5862.032764593794, 5876.44173803488, 5906.7637294508595, 5665.575081868794, 5759.193712880284, 5767.336756273083, 5790.826275211751, 5793.826185214451, 5894.233749612523, 5951.077582974646, 6047.606905551125, 6064.211652485149, 6071.666058366833, 5810.070388737781, 5821.155932389865, 5821.650700957956, 5822.970885145547, 5828.300603927386, 5557.444255574572, 5863.882722345615, 5899.557533185114, 5904.940950590439, 5905.91141132892, 5655.462731040545, 5684.857878553069, 5697.373288938296, 5748.252727145612, 5803.535717142534, 5672.5461963042035, 5676.4323567642905, 5684.914726279027, 5698.544116470755, 5700.002499562477, 5278.445763194809, 5576.358718747234, 5591.245181900392, 5600.467955544217, 5607.523360514238, 5450.400455949763, 5464.672119672673, 5670.858228544154, 5795.594308398372, 5797.449242321973, 5581.7209139543675, 5620.718964051863, 5627.5497960162265, 5629.746661400165, 5669.6314739541795], "unit": "score", "name": "dojo.html", "value": 5307.723274840828}, {"lowerIsBetter": false, "replicates": [557.4425574425575, 583.4398976982097, 592.3602509289966, 604.1330690459192, 609.1471939284997, 29416.411671766553, 37432.43851342232, 37774.24451510975, 37935.24129517408, 37977.620223797756, 41446.378304325386, 41871.37192942108, 41924.0, 42019.0, 42056.0, 7486.513376630529, 7619.1238007629, 8728.869066963985, 8907.287417006624, 8911.465312081264, 10391.116755075827, 10618.893811061867, 10627.681169564925, 10631.255812093157, 10634.840477392845, 10170.38977661339, 10285.742856428575, 10290.176785857113, 10291.125254353388, 10345.275830691817, 7623.618819059025, 7750.534967901944, 10127.189824813997, 10128.64549740763, 10461.581536738522, 10018.749531261705, 10132.898671013269, 10154.339967902062, 10210.795784084277, 10261.230407719451, 38129.618703812885, 38626.42060369097, 38651.420228696596, 38664.0, 38712.419313710314, 3236.4983427568527, 3252.317013427183, 3295.8846440374473, 3404.3191361727504, 3550.0592343029116, 29471.85264073666, 29523.409531809244, 29582.70417295821, 29618.25954351137, 30040.0, 3517.0503963929596, 3562.6615471530163, 3586.7668601540818, 3633.8728144514816, 3668.724845636588, 257743.0, 259188.0, 259196.0, 259454.0, 259600.0, 53902.46097539053, 54475.72762136164, 54485.72757136189, 54634.0, 54635.180472292945, 56584.71707641435, 58066.4193358061, 59761.701191494634, 59928.40071599316, 60998.0, 14423.206723630092, 14593.78109328361, 14693.26533673312, 14698.11811291326, 14704.705905881823, 10859.891401086046, 10889.292196007234, 10907.618233361953, 11002.119830413547, 11031.062359699356, 19392.4182274532, 19724.802751972584, 19730.112144953513, 19730.40808775739, 19785.40643780689, 7448.813779655552, 7585.886211706828, 7694.615269236628, 7711.344535714415, 7788.0, 890.0387581412059, 948.7390967483997, 1004.8492726090999, 1015.243643485608, 1032.3547782635853, 24545.38636534065, 26262.6060609091, 26539.203823885313, 26666.333341666614, 26732.59901101485, 979.7844474215804, 988.081084591337, 1042.1402343067, 1076.9983914959164, 1109.2235435195234, 13624.591262262147, 13989.580312590639, 14014.71970560583, 14092.154470731788, 14170.149791012573, 328492.0, 329506.0, 330634.0, 331589.0, 331914.0, 50455.0, 50613.0, 50662.0, 50688.98622027539, 50806.49193508018, 1176.5411489519095, 1193.659806955031, 1253.2793643654934, 1299.7790375636164, 1306.3076569418224, 25358.87320563459, 26391.868040659672, 26447.73552264453, 26471.73528264693, 26505.734942650328, 42592.14815703731, 43002.569974299855, 43027.784861075495, 43053.78473107614, 43165.78417107894, 303848.0, 305486.0, 305903.0, 306463.0, 306782.0, 27531.44937101287, 27902.3024424391, 29381.26546836346, 30993.69006309998, 31416.37167256688, 39651.60348396479, 39947.2010559793, 40031.39952900651, 40645.39031914583, 40832.0, 33511.0, 33621.83189084137, 33821.83089084539, 34605.653943460246, 35153.47269790904, 27622.171334859988, 33046.83476582602, 33918.83040584781, 34095.82952085323, 34171.82914085513, 27636.58545121865, 33268.0, 34138.31723365568, 34202.65797341995, 34665.0, 27215.45569088647, 30088.09735707932, 31308.843455782575, 32250.35499290048, 32334.0, 22733.204337848096, 23330.300090997298, 23932.52134957326, 23968.76031239665, 24394.26817195487], "unit": "score", "name": "ext.html", "value": 18060.8112585104}, {"lowerIsBetter": false, "replicates": [359.6547314578005, 362.0405924300605, 365.3496775739184, 366.8679275460834, 367.96320367963204, 13472.730545389086, 13514.72970540591, 16249.43126990554, 16312.91843540782, 16908.32366705332, 14260.714785704306, 14624.195669238188, 16864.0, 17123.22945467454, 17560.473185804414, 5391.81128660496, 5503.504684578387, 5512.448755124476, 5513.228148059255, 5517.36550296717, 4006.1186538961383, 4096.97951510242, 5246.816361427351, 5427.213054107152, 5434.049041417736, 5869.178315035899, 5977.521798256129, 5993.430624090704, 6037.003894357425, 6038.667873266991, 5822.3886491918165, 5949.791757288474, 5955.047192449188, 5962.314333851597, 5982.730777115018, 5229.477052294778, 5250.5274525292525, 5256.106461901486, 5259.421463638997, 5260.526552610245, 19534.80465195344, 20006.299779507648, 20018.399448016437, 20839.16643334265, 21152.153913843427, 1978.9010549472468, 2310.2145270608075, 2379.89290481927, 2393.533261014103, 2456.5086982603552, 9278.628854845798, 9563.139317461393, 9563.665271715527, 10531.368117912873, 13050.15174013686, 1778.7065134252832, 1780.9910950445164, 1794.4257837492007, 1826.0960824392012, 1826.196473551633, 59104.40895591075, 61507.38492615106, 61895.690521547556, 62312.37687623111, 62424.0, 9550.331476796557, 9576.808463830685, 9765.853512197322, 9770.26722995778, 9873.111419972238, 12316.445759940823, 12356.505739770308, 12405.069619778553, 12414.0, 12415.379231038592, 7132.572045677276, 7252.419806415474, 7289.157228680819, 7323.707051717978, 7352.228016058344, 6956.443484521226, 7001.684924178322, 7061.752838650726, 7167.677454514559, 7185.53294035886, 4009.7770180094767, 4027.4160246764054, 4172.374143878443, 4231.703780735319, 4271.893202669896, 1657.839512341366, 1699.1589163363967, 1726.620143568413, 1728.2395745871777, 1761.9911900440416, 854.3763052971242, 896.4979611417627, 911.3256190419042, 953.3374304858196, 986.5609803637456, 15808.36766529349, 15929.203539822962, 16443.506694799176, 16816.159192040595, 17027.233774480177, 777.708359365238, 902.5036230073565, 906.2251774732508, 920.921721653667, 926.0600490502146, 9614.759631009281, 9715.46564938935, 9818.410895346302, 9835.901640983642, 9861.161801246973, 493434.0, 493815.0, 496195.0, 517385.0, 521630.0, 72017.27982720106, 78251.2174878244, 80035.0, 81240.59379703182, 81613.0, 1045.4563626913962, 1067.6423398161548, 1069.0859315285475, 1086.8532748078908, 1111.0944580166977, 15311.693766124838, 15414.229288535304, 15473.922630386776, 15576.92211538935, 15872.92063539675, 31437.842810786715, 32172.678273217905, 32473.0, 36309.63690363063, 37144.07139821526, 36276.0, 36800.815995919846, 43385.566144338154, 45056.324155137045, 45614.54385456103, 9111.271098311987, 9382.29632777558, 9387.671431499864, 9866.654667086617, 9935.552900119368, 17604.559886002953, 17698.380556680968, 17952.730709039115, 17973.64052718912, 18073.728894066335, 14404.20776857241, 14668.55994320172, 14848.109113453227, 14852.183129927958, 15179.468718594797, 14027.088239264414, 14354.49759258421, 14397.784033239719, 14701.92649036748, 14818.184999825113, 11468.942655287005, 11735.119866010255, 14295.0, 14552.27238638085, 14998.550043498712, 7854.4894581851995, 7863.84272314562, 8039.557824319719, 9420.95289523548, 9601.47191904452, 10102.646407375707, 10267.486625668836, 11254.437278135896, 14331.641708956942, 14689.045212061183], "unit": "score", "name": "jquery.html", "value": 8695.418754321052}, {"lowerIsBetter": false, "replicates": [1397.5946975377142, 1478.3495262084684, 1530.4260902161689, 1582.6834633073381, 1714.0915314883116, 6774.4241739452145, 7295.452841036924, 7430.851382972337, 7452.5901075440825, 7457.477976541631, 7502.36229920456, 7568.0, 7635.732749353774, 7641.388688904888, 7644.044494438195, 1912.3402426162952, 1954.4332143678387, 2192.4957259830207, 2248.280550223929, 2251.3583628665833, 2136.2629892687078, 2181.9526627218943, 2182.3671135370723, 2183.5851188274255, 2183.6396994495967, 2126.5853158634072, 2151.397608669575, 2233.4974630708125, 2233.8547994380397, 2234.8323875709307, 2148.9140434382607, 2160.038782741665, 2168.533765240473, 2187.3437968609355, 2190.7809219078126, 2177.4447515883508, 2201.97608112227, 2202.4603972026794, 2203.0, 2204.1183526589334, 7235.638218089074, 7251.5286506376915, 7291.052163218747, 7308.707651693926, 7313.195548489662, 4394.209042372372, 4495.23580991229, 4499.61753250974, 4500.909981800379, 4504.774761261924, 2936.765058795291, 2957.467655821951, 3016.306249562591, 3016.834074125922, 3034.1656044587694, 1024.3085917006065, 1033.364480844283, 1056.8573242612304, 1068.8931106889327, 1069.7432616172064, 10024.248181386425, 10194.796104077877, 10198.694039178836, 10202.846957295647, 10256.128229100535, 4070.6946978976102, 4074.8573799916862, 4145.875623731293, 4161.25097482456, 4163.5836416358125, 8831.69089081879, 8839.29285657146, 8880.289576833839, 8882.200601945726, 8886.37795354319, 4635.907281854344, 4639.466461356919, 4642.930356044662, 4643.419572553431, 4645.0477652081245, 4171.958280417218, 4229.851955181553, 4244.702870799015, 4247.936280955788, 4265.104328091135, 3290.8683652654104, 3349.4138525757894, 3517.9648203517636, 3655.9634403656155, 3742.8128593570214, 1173.202222488699, 1186.2822992089834, 1187.6199616122758, 1189.7679952409371, 1198.670365649436, 1007.0, 1007.7279134633754, 1063.5586231713753, 1119.5577746789972, 1283.5507572349602, 6984.301569842975, 7007.264237255014, 7083.5041547091205, 7094.574325540484, 7102.644867756591, 1160.2168536238005, 1164.7845148647527, 1191.803352446854, 1217.0993464836135, 1221.183800623053, 5533.584981126432, 5557.777688892399, 5569.610127291051, 5573.888522229533, 5607.327120745536, 8650.78373040679, 8772.78068048304, 8823.647054117764, 8852.601632926533, 8873.423227490193, 8693.521856297837, 8775.385722999328, 8778.561071946377, 8782.780430489289, 8788.516631585324, 6905.965470172617, 6992.999999999898, 7018.964905175441, 7021.0, 7056.894146587805, 7024.5434046786795, 7056.929430705627, 7069.222385537484, 7078.893816592652, 7078.929210707827, 7813.218678132369, 7955.403344749051, 8156.632951517077, 8174.509529428254, 8175.345972322319, 8113.634886430007, 8137.6744930204495, 8195.139510351328, 8213.630386632496, 8236.464629799044, 6525.543211975116, 6639.634820084942, 6650.933490665031, 6653.401193892573, 6661.633610151294, 6401.071844582416, 6518.250401203923, 6787.253402125861, 6944.4444444445335, 7076.71693132269, 6686.933130668631, 6701.966490167518, 6782.593044417351, 6823.624700641512, 6850.21222559412, 6578.24350199714, 6628.53600247978, 6647.667616619053, 6749.5612785168805, 6754.729810807513, 6545.607263564201, 6550.0, 6553.2136143663065, 6557.770478033246, 6574.539782215199, 6201.96899015502, 6210.472109870711, 6245.0632405139595, 6276.246850377984, 6278.434940855345, 6179.320274769681, 6223.066540019034, 6306.590071645328, 6313.842153946188, 6314.810555683337], "unit": "score", "name": "mootools.html", "value": 4335.127646920969}, {"lowerIsBetter": false, "replicates": [318.20448877805484, 325.3184578308443, 326.7059646318313, 327.7787493441927, 331.5606820962226, 5874.2950845898495, 5920.674362910038, 5935.495482883949, 5957.6127551709105, 5976.52187824974, 5621.381648018714, 5680.630759000662, 5738.3974682658245, 5818.883622327551, 5826.766929322822, 4522.253828118356, 4533.387992620987, 4536.160810250114, 4540.364348991127, 4547.272436410167, 4326.826926922935, 4540.2054640437955, 4541.45502539694, 4543.568361005699, 4552.749598772066, 4371.14762621289, 4388.363687265344, 4469.82120715171, 4473.172463094322, 4474.284114541674, 4437.4009508716235, 4441.600255976961, 4445.1331990261915, 4458.264386376244, 4464.084862603158, 3903.8048097595292, 3906.8827935161708, 3907.4529565860803, 3909.843606255746, 3913.6086391360923, 5456.072467680504, 5562.749676264578, 5567.3040869891265, 5567.66594004361, 5569.10894256917, 5235.869103272411, 5240.3187585614005, 5244.292020577212, 5246.580273578104, 5250.3962044364625, 6169.0, 6175.44421002112, 6191.442770150708, 6191.752329906798, 6200.3799620037635, 4366.759828209447, 4367.301231802896, 4372.060007098489, 4373.300271956472, 4388.188185185719, 6334.778282760081, 6445.452136568398, 6467.967660161716, 6489.772857949996, 6491.8052458425855, 4483.327500874895, 4491.663125265618, 4495.348174514677, 4502.212112880233, 4507.549245075466, 4534.36518887356, 4543.091381723669, 4543.522930092358, 4549.749763763025, 4566.70316429431, 5225.3207083079715, 5229.738513074407, 5245.580353571705, 5252.080885844962, 5252.1596544552685, 6148.200733904564, 6256.155419018374, 6260.812175634738, 6275.090111933744, 6282.591631543935, 1596.6806638672313, 1615.055192712253, 1618.1828176770655, 1619.3117924882113, 1620.5786495511252, 1081.2539347849959, 1094.195766111907, 1097.1223021582703, 1102.1293178388983, 1111.4498323330004, 5988.071848863433, 5998.280206375263, 5998.340182579913, 6079.574429789961, 6086.02623580225, 6420.101185833987, 6475.902861457082, 6478.125453063776, 6479.384458476437, 6483.902741458882, 5842.415758424208, 5916.1421593868645, 5966.463018328372, 5981.790637327673, 5982.282126144803, 3435.4159792835276, 3535.0101971448034, 3544.113971507123, 3546.1666508370513, 3548.7693299935936, 6690.698918548677, 6691.899621505681, 6695.799126026227, 6696.363845434676, 6708.631025293558, 6681.9331806682285, 6687.832804179837, 6689.297623749533, 6690.799276021728, 6695.497837662195, 6535.0850880876715, 6712.2616512184595, 6715.764948226789, 6733.595984240863, 6755.459563234929, 6547.770828020996, 6551.312112228147, 6557.540972131905, 6562.146920900444, 6567.014947757874, 6356.936430635635, 6463.062855885776, 6480.287168411565, 6483.967580162069, 6487.935120648922, 6687.264400915798, 6706.8993965089585, 6713.664316784044, 6714.362135597111, 6719.496037797087, 4403.669724770591, 4440.7335559866515, 4451.10977804434, 4452.465704115527, 4453.465584129795, 6530.183727034121, 6536.379043990813, 6550.377714117151, 6565.606063636197, 6568.967155164193, 6252.812415627538, 6270.2475702915945, 6341.0805433212845, 6371.04434334835, 6377.330380310001, 6297.244330680164, 6350.555461117678, 6352.555321127476, 6352.555321127476, 6355.682215889279, 6240.594361366497, 6245.0632405139595, 6248.968755156195, 6252.0, 6252.187215661935, 6259.654174352536, 6385.042243663488, 6390.265119511316, 6398.5521013528605, 6402.6158430494315, 6234.594751341148, 6239.282482514569, 6240.7503699851495, 6241.21984751906, 6250.812475625738], "unit": "score", "name": "prototype.html", "value": 4739.180780851758}, {"lowerIsBetter": false, "replicates": [721.4372789224403, 750.4784174998376, 821.5235163605109, 832.8209434971479, 839.7396806989832, 11702.531898724052, 11940.761184776311, 11978.580749673763, 11989.820152697717, 11990.40047997601, 11790.4694288757, 11828.112891533148, 11839.881601183986, 11949.163558550905, 11954.0, 662.3608218069573, 676.8950812624051, 677.6882633988371, 678.199724325296, 787.6494959742917, 803.907550631679, 811.2982270336146, 818.5088946632033, 823.4482896459386, 827.5613924619961, 838.9035260944978, 854.9230569248766, 856.1310270075878, 856.1395797223781, 856.2251162697769, 698.5145323999848, 706.1420374245316, 830.9542975136366, 848.6266042941086, 856.028407757197, 609.5123900879323, 614.7940439952621, 623.7598524568028, 624.1729708136737, 624.7657128576784, 12304.200226985307, 12596.433160507799, 12698.492060317576, 12699.0, 12717.682057948625, 11408.315501069963, 11673.416329183592, 11881.94059029708, 12636.11547191697, 13220.206787592775, 9951.203903687687, 10023.74940626483, 10057.798844023151, 10101.797964040752, 10137.594496220143, 3633.7274704397278, 3644.1982763791925, 3648.343298206348, 3675.8713445029293, 3781.3004594149897, 46049.76975115136, 46305.30542041872, 46635.76682116568, 46851.0, 47731.28403073957, 9815.656452024288, 10022.670325736774, 10169.644062457779, 10231.846522302172, 10345.844812327821, 18794.90602547006, 18843.528911777314, 18863.96248206362, 18871.716924246146, 18877.33929312495, 7102.254263302382, 7129.429645628337, 7220.855582888418, 7349.154847192534, 7545.0, 4080.6939479539155, 4176.352665336878, 4202.41166236721, 4213.957860421357, 4215.093754842662, 2869.827810331345, 2895.0, 2896.898608548691, 2897.608822808894, 2938.030449951511, 516.3055690096813, 521.7652056574557, 529.3912001198576, 532.0370130064596, 540.7890922540213, 599.5593238969354, 601.4076135007015, 606.5299392970484, 622.7135517661926, 650.9967450162719, 8346.248837604524, 9018.409776225964, 9291.48896810682, 9339.159475647088, 9430.622775089058, 673.6732684647942, 677.3091446724313, 691.8692914561649, 704.4505285877024, 710.4174576846935, 3880.941785873214, 3985.720999530005, 4046.4132700758814, 4148.771817550064, 4152.91694166115, 57675.13487297694, 57791.422085778606, 58237.70881145567, 58455.0, 58548.121778173365, 51594.0, 51887.48112518902, 53293.46706532885, 53557.464425356025, 53692.0, 45116.0, 46189.76905115453, 46319.0, 46506.767466162455, 48380.0, 7914.44598878073, 8232.34141268709, 8405.831883362422, 8474.374136611465, 8873.955630221808, 33561.0, 33719.49420758642, 34089.318213635095, 35153.47269790904, 35385.0, 43546.34680479859, 45290.773546132055, 45882.311765324215, 46113.0, 46412.767936160104, 10031.849522257025, 10128.113596700172, 10194.541245644112, 10732.517036733521, 11292.887071129513, 11388.202825802446, 11888.76222475563, 11907.106966977684, 12150.513979440724, 12273.754524909273, 10699.090577300705, 10749.516271767632, 11007.339559626447, 11044.613438529614, 11117.166212534254, 10606.522706478381, 10717.654886150376, 10956.452177390938, 10966.0, 10994.34033957965, 7449.92550074514, 10367.94816025915, 10554.419506926886, 10794.190435717195, 10877.184211184034, 9225.630974760934, 9490.0, 9715.805683886141, 9873.25950553697, 9942.105210531086, 9025.909740902507, 9289.814203716023, 9332.72001839946, 9473.384230025027, 9532.714018579454], "unit": "score", "name": "yui.html", "value": 6146.618361938663}], "name": "dromaeo_css", "value": 6871.518997092957}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 105.0, 109.0, 111.0, 110.0, 98.0, 109.0, 112.0, 116.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 149.0, 162.0, 133.0, 147.0, 149.0, 125.0, 160.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 141.8}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 159.0, 159.0, 160.0, 160.0, 163.0, 159.0, 162.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 84.0, 97.0, 71.0, 71.0, 72.0, 110.0, 87.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 141.0, 94.0, 94.0, 93.0, 145.0, 93.0, 93.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 57.0, 59.0, 57.0, 57.0, 67.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 72.0, 66.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 84.0, 83.0, 86.0, 84.0, 84.0, 84.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [117.0, 115.0, 130.0, 118.0, 127.0, 115.0, 122.0, 122.0, 114.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [149.0, 158.0, 149.0, 151.0, 150.0, 147.0, 153.0, 155.0, 150.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.7}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 65.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1498.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [190.00570017100512], "unit": "score", "name": "DeltaBlue", "value": 347.979034}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [2066.115702479339], "unit": "score", "name": "RayTrace", "value": 358.1546759999999}, {"lowerIsBetter": false, "replicates": [767.638036809816], "unit": "score", "name": "Earley", "value": 868.1995524475527}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Splay", "value": 148.232129}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20060.53297150074}]} 04:09:55 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20060.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1498.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6871.52"}}} 04:09:56 INFO - Return code: 0 04:09:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:09:56 ERROR - # TBPL SUCCESS # 04:09:56 INFO - Running post-action listener: _resource_record_post_action 04:09:56 INFO - Running post-run listener: _resource_record_post_run 04:09:57 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 10305536; Write bytes: 480157696; Read time: 3468; Write time: 621188 04:09:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20017152; Read time: 0; Write time: 34468 04:09:57 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 10305536; Write bytes: 459952128; Read time: 3468; Write time: 586696 04:09:57 INFO - Running post-run listener: _upload_blobber_files 04:09:57 INFO - Blob upload gear active. 04:09:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:09:57 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 04:09:57 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:09:57 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:09:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:09:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:09:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:58 INFO - (blobuploader) - INFO - Done attempting. 04:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:09:59 INFO - (blobuploader) - INFO - Done attempting. 04:09:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:09:59 INFO - Return code: 0 04:09:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:09:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:09:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f7a8d2bebcc0b5e71ec1275f8eb250c4498d0bd9a873dbd8f0ed4be257a98b4ea4137c2eb2b33652985c018d18bc8db5dd01bc27067b5f3acccf42eebd364e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00acedfb13cb724101bfa515a988567eb0fb654c04637eea524a3553d17a0ad92011ddc53b91f5376ad252912dbb8c658128c4a295b55964155d6716fbbd310b"} 04:09:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:09:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:09:59 INFO - Contents: 04:09:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f7a8d2bebcc0b5e71ec1275f8eb250c4498d0bd9a873dbd8f0ed4be257a98b4ea4137c2eb2b33652985c018d18bc8db5dd01bc27067b5f3acccf42eebd364e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00acedfb13cb724101bfa515a988567eb0fb654c04637eea524a3553d17a0ad92011ddc53b91f5376ad252912dbb8c658128c4a295b55964155d6716fbbd310b"} 04:09:59 INFO - Copying logs to upload dir... 04:09:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1284.550301 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-12-18 04:09:59.274763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:59.278826) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79f7a8d2bebcc0b5e71ec1275f8eb250c4498d0bd9a873dbd8f0ed4be257a98b4ea4137c2eb2b33652985c018d18bc8db5dd01bc27067b5f3acccf42eebd364e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00acedfb13cb724101bfa515a988567eb0fb654c04637eea524a3553d17a0ad92011ddc53b91f5376ad252912dbb8c658128c4a295b55964155d6716fbbd310b"} build_url:https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/CJXEYUNyQIyMuac6SJU8mQ/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/Mozilla-Inbound/sha512/79f7a8d2bebcc0b5e71ec1275f8eb250c4498d0bd9a873dbd8f0ed4be257a98b4ea4137c2eb2b33652985c018d18bc8db5dd01bc27067b5f3acccf42eebd364e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/00acedfb13cb724101bfa515a988567eb0fb654c04637eea524a3553d17a0ad92011ddc53b91f5376ad252912dbb8c658128c4a295b55964155d6716fbbd310b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:59.304351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:59.304690) ========= 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=0cff312cb257a7829adc5a5d000001df-1450437822.442-2059329676 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 04:09:59.389504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 04:09:59.389918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 04:09:59.390248) ========= ========= Total master_lag: 0.22 =========