builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1453216001.51 results: success (0) buildid: 20160119043043 builduid: cc1fd63a126c4e8e8ac0203b36e39b92 revision: b67316254602a63bf4e568198a5c7d3288a9db27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.515439) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.515875) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.516205) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006339 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.549159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.549637) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.575782) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.576215) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004619 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.626565) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.627020) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.627415) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.627966) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-19 07:06:43-- 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% 223M=0s 2016-01-19 07:06:43 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.733659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.734352) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021312 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.785111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:41.785476) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b67316254602a63bf4e568198a5c7d3288a9db27 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b67316254602a63bf4e568198a5c7d3288a9db27 --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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-19 07:06:43,788 truncating revision to first 12 chars 2016-01-19 07:06:43,788 Setting DEBUG logging. 2016-01-19 07:06:43,788 attempt 1/10 2016-01-19 07:06:43,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b67316254602?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-19 07:06:44,031 unpacking tar archive at: mozilla-central-b67316254602/testing/mozharness/ program finished with exit code 0 elapsedTime=0.557186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.359702) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.360516) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004675 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.414186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.414605) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.432386) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.432673) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-19 07:06:42.433080) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-19 07:06:42.433418) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:44 INFO - MultiFileLogger online at 20160119 07:06:44 in /builds/slave/test-pgo 07:06:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:06:44 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:06:44 INFO - {'append_to_log': False, 07:06:44 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:06:44 INFO - 'blob_upload_branch': 'Firefox', 07:06:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:06:44 INFO - 'branch': 'Firefox', 07:06:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:44 INFO - 'config_files': ('talos/linux_config.py',), 07:06:44 INFO - 'default_actions': ('clobber', 07:06:44 INFO - 'read-buildbot-config', 07:06:44 INFO - 'download-and-extract', 07:06:44 INFO - 'populate-webroot', 07:06:44 INFO - 'create-virtualenv', 07:06:44 INFO - 'install', 07:06:44 INFO - 'run-tests'), 07:06:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:44 INFO - 'download_minidump_stackwalk': True, 07:06:44 INFO - 'download_symbols': 'ondemand', 07:06:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:44 INFO - 'installer_path': 'installer.exe', 07:06:44 INFO - 'log_level': 'info', 07:06:44 INFO - 'log_name': 'talos', 07:06:44 INFO - 'log_to_console': True, 07:06:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:44 INFO - 'opt_config_files': (), 07:06:44 INFO - 'pip_index': False, 07:06:44 INFO - 'sps_profile': False, 07:06:44 INFO - 'sps_profile_interval': 0, 07:06:44 INFO - 'suite': 'dromaeojs', 07:06:44 INFO - 'system_bits': '32', 07:06:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:44 INFO - 'title': 'talos-linux64-ix-067', 07:06:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:44 INFO - 'use_talos_json': True, 07:06:44 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:06:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:44 INFO - 'work_dir': 'build'} 07:06:44 INFO - ##### 07:06:44 INFO - ##### Running clobber step. 07:06:44 INFO - ##### 07:06:44 INFO - Running pre-action listener: _resource_record_pre_action 07:06:44 INFO - Running main action method: clobber 07:06:44 INFO - rmtree: /builds/slave/test-pgo/build 07:06:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:06:45 INFO - Running post-action listener: _resource_record_post_action 07:06:45 INFO - ##### 07:06:45 INFO - ##### Running read-buildbot-config step. 07:06:45 INFO - ##### 07:06:45 INFO - Running pre-action listener: _resource_record_pre_action 07:06:45 INFO - Running main action method: read_buildbot_config 07:06:45 INFO - Using buildbot properties: 07:06:45 INFO - { 07:06:45 INFO - "project": "", 07:06:45 INFO - "product": "firefox", 07:06:45 INFO - "script_repo_revision": "production", 07:06:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:06:45 INFO - "repository": "", 07:06:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:06:45 INFO - "buildid": "20160119043043", 07:06:45 INFO - "pgo_build": "True", 07:06:45 INFO - "basedir": "/builds/slave/test-pgo", 07:06:45 INFO - "buildnumber": 648, 07:06:45 INFO - "slavename": "talos-linux64-ix-067", 07:06:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:06:45 INFO - "platform": "ubuntu64_hw", 07:06:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:06:45 INFO - "branch": "mozilla-central", 07:06:45 INFO - "repo_path": "mozilla-central", 07:06:45 INFO - "revision": "b67316254602a63bf4e568198a5c7d3288a9db27", 07:06:45 INFO - "stage_platform": "linux64-pgo", 07:06:45 INFO - "builduid": "cc1fd63a126c4e8e8ac0203b36e39b92", 07:06:45 INFO - "slavebuilddir": "test" 07:06:45 INFO - } 07:06:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:06:45 INFO - Running post-action listener: _resource_record_post_action 07:06:45 INFO - ##### 07:06:45 INFO - ##### Running download-and-extract step. 07:06:45 INFO - ##### 07:06:45 INFO - Running pre-action listener: _resource_record_pre_action 07:06:45 INFO - Running main action method: download_and_extract 07:06:45 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:06: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')]} 07:06:45 INFO - https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/test_packages.json 07:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/test_packages.json 07:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:06:49 INFO - Downloaded 1448 bytes. 07:06:49 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:06:49 INFO - Using the following test package requirements: 07:06:49 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:49 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:49 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:49 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'jsshell-linux-x86_64.zip'], 07:06:49 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:49 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:49 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:49 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:49 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:49 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:49 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:49 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:49 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:49 INFO - https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:06:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:06:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:06:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:06:59 INFO - Downloaded 22483938 bytes. 07:06:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:06:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:07:00 INFO - Return code: 0 07:07:00 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 07:07: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')]} 07:07:00 INFO - https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:01 INFO - Downloaded 22483938 bytes. 07:07:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:07:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:07:02 INFO - Return code: 0 07:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:02 INFO - https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:07:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:07:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:03 INFO - Downloaded 11132144 bytes. 07:07:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:07:03 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:07:03 INFO - Return code: 0 07:07:03 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')]} 07:07:03 INFO - https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:07:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PjzTeLDgTmOKOYptn0lFBA/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 07:07:04 INFO - Downloaded 55959200 bytes. 07:07:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:04 INFO - mkdir: /builds/slave/test-pgo/properties 07:07:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:07:04 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:07:04 INFO - Contents: 07:07:04 INFO - build_url:https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:07:04 INFO - Running post-action listener: _resource_record_post_action 07:07:04 INFO - Running post-action listener: set_extra_try_arguments 07:07:04 INFO - ##### 07:07:04 INFO - ##### Running populate-webroot step. 07:07:04 INFO - ##### 07:07:04 INFO - Running pre-action listener: _resource_record_pre_action 07:07:04 INFO - Running main action method: populate_webroot 07:07:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:07:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:07:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:07:04 INFO - '--tppagecycles', 07:07:04 INFO - '7'], 07:07:04 INFO - 'tests': ['tsvgm']}}, 07:07:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:07:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:07:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:07:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:07:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'tests': ['damp', 'tps']}, 07:07:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['damp', 'tps']}, 07:07:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:07:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:07:04 INFO - 'other': {'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'other_l64': {'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'other_nol64': {'tests': ['a11yr', 07:07:04 INFO - 'ts_paint', 07:07:04 INFO - 'tpaint', 07:07:04 INFO - 'sessionrestore', 07:07:04 INFO - 'sessionrestore_no_auto_restore']}, 07:07:04 INFO - 'svgr': {'tests': ['tsvgx', 07:07:04 INFO - 'tsvgr_opacity', 07:07:04 INFO - 'tart', 07:07:04 INFO - 'tscrollx', 07:07:04 INFO - 'cart']}, 07:07:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['tsvgx', 07:07:04 INFO - 'tsvgr_opacity', 07:07:04 INFO - 'tart', 07:07:04 INFO - 'tscrollx', 07:07:04 INFO - 'cart']}, 07:07:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'tests': ['tp5o']}, 07:07:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'talos_options': ['--e10s'], 07:07:04 INFO - 'tests': ['tp5o']}, 07:07:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'talos_options': ['--xperf_path', 07:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:04 INFO - 'tests': ['tp5n']}, 07:07:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:07:04 INFO - 'talos_options': ['--e10s', 07:07:04 INFO - '--xperf_path', 07:07:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:07:04 INFO - 'tests': ['tp5n']}}, 07:07:04 INFO - 'talos.zip': {'path': '', 07:07:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:07:04 INFO - Running post-action listener: _resource_record_post_action 07:07:04 INFO - ##### 07:07:04 INFO - ##### Running create-virtualenv step. 07:07:04 INFO - ##### 07:07:04 INFO - Running pre-action listener: _resource_record_pre_action 07:07:04 INFO - Running main action method: create_virtualenv 07:07:04 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:07:04 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 07:07:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:07:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:07:05 INFO - Using real prefix '/usr' 07:07:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:07:05 INFO - Installing distribute.............................................................................................................................................................................................done. 07:07:07 INFO - Installing pip.................done. 07:07:07 INFO - Return code: 0 07:07:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:07: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')]} 07:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:07: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 pip>=1.5 07:07:07 INFO - Using env: {'DISPLAY': ':0', 07:07:07 INFO - 'HOME': '/home/cltbld', 07:07:07 INFO - 'LANG': 'en_US.UTF-8', 07:07:07 INFO - 'LANGUAGE': 'en_US:en', 07:07:07 INFO - 'LOGNAME': 'cltbld', 07:07:07 INFO - 'MAIL': '/var/mail/cltbld', 07:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:07 INFO - 'MOZ_NO_REMOTE': '1', 07:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:07 INFO - 'NO_EM_RESTART': '1', 07:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:07 INFO - 'SHELL': '/bin/bash', 07:07:07 INFO - 'SHLVL': '1', 07:07:07 INFO - 'TERM': 'linux', 07:07:07 INFO - 'TMOUT': '86400', 07:07:07 INFO - 'USER': 'cltbld', 07:07:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:07 INFO - '_': '/tools/buildbot/bin/python'} 07:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:07 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 07:07:07 INFO - Cleaning up... 07:07:07 INFO - Return code: 0 07:07:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:07: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')]} 07:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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')]} 07:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07: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', '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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:07: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 psutil>=0.7.1 07:07:07 INFO - Using env: {'DISPLAY': ':0', 07:07:07 INFO - 'HOME': '/home/cltbld', 07:07:07 INFO - 'LANG': 'en_US.UTF-8', 07:07:07 INFO - 'LANGUAGE': 'en_US:en', 07:07:07 INFO - 'LOGNAME': 'cltbld', 07:07:07 INFO - 'MAIL': '/var/mail/cltbld', 07:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:07 INFO - 'MOZ_NO_REMOTE': '1', 07:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:07 INFO - 'NO_EM_RESTART': '1', 07:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:07 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:07 INFO - 'SHELL': '/bin/bash', 07:07:07 INFO - 'SHLVL': '1', 07:07:07 INFO - 'TERM': 'linux', 07:07:07 INFO - 'TMOUT': '86400', 07:07:07 INFO - 'USER': 'cltbld', 07:07:07 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:07 INFO - '_': '/tools/buildbot/bin/python'} 07:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:07 INFO - Downloading/unpacking psutil>=0.7.1 07:07:07 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 07:07:07 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 07:07:07 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 07:07:07 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 07:07:07 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 07:07:07 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 07:07:09 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:07:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:07:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:09 INFO - Installing collected packages: psutil 07:07:09 INFO - Running setup.py install for psutil 07:07:09 INFO - building 'psutil._psutil_linux' extension 07:07:09 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 07:07:10 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 07:07:10 INFO - building 'psutil._psutil_posix' extension 07:07:10 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 07:07:10 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 07:07:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:07:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:07:10 INFO - Successfully installed psutil 07:07:10 INFO - Cleaning up... 07:07:10 INFO - Return code: 0 07:07:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:07:10 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')]} 07:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:10 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')]} 07:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:10 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:10 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 07:07:10 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 07:07:10 INFO - Using env: {'DISPLAY': ':0', 07:07:10 INFO - 'HOME': '/home/cltbld', 07:07:10 INFO - 'LANG': 'en_US.UTF-8', 07:07:10 INFO - 'LANGUAGE': 'en_US:en', 07:07:10 INFO - 'LOGNAME': 'cltbld', 07:07:10 INFO - 'MAIL': '/var/mail/cltbld', 07:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:10 INFO - 'MOZ_NO_REMOTE': '1', 07:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:10 INFO - 'NO_EM_RESTART': '1', 07:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:10 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:10 INFO - 'SHELL': '/bin/bash', 07:07:10 INFO - 'SHLVL': '1', 07:07:10 INFO - 'TERM': 'linux', 07:07:10 INFO - 'TMOUT': '86400', 07:07:10 INFO - 'USER': 'cltbld', 07:07:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:10 INFO - '_': '/tools/buildbot/bin/python'} 07:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:07:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:07:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:07:12 INFO - Installing collected packages: mozsystemmonitor 07:07:12 INFO - Running setup.py install for mozsystemmonitor 07:07:12 INFO - Successfully installed mozsystemmonitor 07:07:12 INFO - Cleaning up... 07:07:12 INFO - Return code: 0 07:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:07:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:07:12 INFO - Using env: {'DISPLAY': ':0', 07:07:12 INFO - 'HOME': '/home/cltbld', 07:07:12 INFO - 'LANG': 'en_US.UTF-8', 07:07:12 INFO - 'LANGUAGE': 'en_US:en', 07:07:12 INFO - 'LOGNAME': 'cltbld', 07:07:12 INFO - 'MAIL': '/var/mail/cltbld', 07:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:12 INFO - 'MOZ_NO_REMOTE': '1', 07:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:12 INFO - 'NO_EM_RESTART': '1', 07:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:12 INFO - 'SHELL': '/bin/bash', 07:07:12 INFO - 'SHLVL': '1', 07:07:12 INFO - 'TERM': 'linux', 07:07:12 INFO - 'TMOUT': '86400', 07:07:12 INFO - 'USER': 'cltbld', 07:07:12 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:12 INFO - '_': '/tools/buildbot/bin/python'} 07:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:07:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:07:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:07:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:07:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:07:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:07:15 INFO - Downloading docopt-0.6.1.tar.gz 07:07:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:07:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:07:15 INFO - Installing collected packages: blobuploader, requests, docopt 07:07:15 INFO - Running setup.py install for blobuploader 07:07:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:07:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:07:15 INFO - Running setup.py install for requests 07:07:15 INFO - Running setup.py install for docopt 07:07:15 INFO - Successfully installed blobuploader requests docopt 07:07:15 INFO - Cleaning up... 07:07:15 INFO - Return code: 0 07:07:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:15 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:15 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 07:07:15 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 07:07:15 INFO - Using env: {'DISPLAY': ':0', 07:07:15 INFO - 'HOME': '/home/cltbld', 07:07:15 INFO - 'LANG': 'en_US.UTF-8', 07:07:15 INFO - 'LANGUAGE': 'en_US:en', 07:07:15 INFO - 'LOGNAME': 'cltbld', 07:07:15 INFO - 'MAIL': '/var/mail/cltbld', 07:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:15 INFO - 'MOZ_NO_REMOTE': '1', 07:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:15 INFO - 'NO_EM_RESTART': '1', 07:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:15 INFO - 'SHELL': '/bin/bash', 07:07:15 INFO - 'SHLVL': '1', 07:07:15 INFO - 'TERM': 'linux', 07:07:15 INFO - 'TMOUT': '86400', 07:07:15 INFO - 'USER': 'cltbld', 07:07:15 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:15 INFO - '_': '/tools/buildbot/bin/python'} 07:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:15 INFO - Running setup.py (path:/tmp/pip-xtYnJq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:16 INFO - Running setup.py (path:/tmp/pip-nMT6cY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:16 INFO - Running setup.py (path:/tmp/pip-gabBBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:16 INFO - Running setup.py (path:/tmp/pip-wtzjZy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:16 INFO - Running setup.py (path:/tmp/pip-8Udxp6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:16 INFO - Running setup.py (path:/tmp/pip-KQtPsc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:16 INFO - Running setup.py (path:/tmp/pip-mmNTfT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:16 INFO - Running setup.py (path:/tmp/pip-2cykkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:16 INFO - Running setup.py (path:/tmp/pip-camV_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:16 INFO - Running setup.py (path:/tmp/pip-QdULp8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:16 INFO - Running setup.py (path:/tmp/pip-IB8GAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:16 INFO - Running setup.py (path:/tmp/pip-v9VyOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:16 INFO - Running setup.py (path:/tmp/pip-0eVavc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:16 INFO - Running setup.py (path:/tmp/pip-nWzT51-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:17 INFO - Running setup.py (path:/tmp/pip-8hL_8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:17 INFO - Running setup.py (path:/tmp/pip-1BkuzU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:17 INFO - Running setup.py (path:/tmp/pip-dh6KX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:07:17 INFO - Running setup.py install for manifestparser 07:07:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:07:17 INFO - Running setup.py install for mozcrash 07:07:17 INFO - Running setup.py install for mozdebug 07:07:17 INFO - Running setup.py install for mozdevice 07:07:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:07:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:07:17 INFO - Running setup.py install for mozfile 07:07:17 INFO - Running setup.py install for mozhttpd 07:07:17 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:07:17 INFO - Running setup.py install for mozinfo 07:07:17 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:07:17 INFO - Running setup.py install for mozInstall 07:07:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Running setup.py install for mozleak 07:07:18 INFO - Running setup.py install for mozlog 07:07:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Running setup.py install for moznetwork 07:07:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Running setup.py install for mozprocess 07:07:18 INFO - Running setup.py install for mozprofile 07:07:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Running setup.py install for mozrunner 07:07:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Running setup.py install for mozscreenshot 07:07:18 INFO - Running setup.py install for moztest 07:07:18 INFO - Running setup.py install for mozversion 07:07:18 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:07:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:07:18 INFO - Cleaning up... 07:07:19 INFO - Return code: 0 07:07:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:19 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')]} 07:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 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')]} 07:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:19 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:19 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 07:07:19 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 07:07:19 INFO - Using env: {'DISPLAY': ':0', 07:07:19 INFO - 'HOME': '/home/cltbld', 07:07:19 INFO - 'LANG': 'en_US.UTF-8', 07:07:19 INFO - 'LANGUAGE': 'en_US:en', 07:07:19 INFO - 'LOGNAME': 'cltbld', 07:07:19 INFO - 'MAIL': '/var/mail/cltbld', 07:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:19 INFO - 'MOZ_NO_REMOTE': '1', 07:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:19 INFO - 'NO_EM_RESTART': '1', 07:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:19 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:19 INFO - 'SHELL': '/bin/bash', 07:07:19 INFO - 'SHLVL': '1', 07:07:19 INFO - 'TERM': 'linux', 07:07:19 INFO - 'TMOUT': '86400', 07:07:19 INFO - 'USER': 'cltbld', 07:07:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:19 INFO - '_': '/tools/buildbot/bin/python'} 07:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:19 INFO - Running setup.py (path:/tmp/pip-NIfPQB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:19 INFO - Running setup.py (path:/tmp/pip-O7Dwnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:19 INFO - Running setup.py (path:/tmp/pip-Z8xVTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:19 INFO - Running setup.py (path:/tmp/pip-8ZanCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:07:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:19 INFO - Running setup.py (path:/tmp/pip-Y1rk1c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:19 INFO - Running setup.py (path:/tmp/pip-10WJLu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:19 INFO - Running setup.py (path:/tmp/pip-AzBaRA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:19 INFO - Running setup.py (path:/tmp/pip-u1ubuy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:19 INFO - Running setup.py (path:/tmp/pip-JpN3RP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:19 INFO - Running setup.py (path:/tmp/pip-lwASKK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:07:19 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)) 07:07:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:19 INFO - Running setup.py (path:/tmp/pip-8xksbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:07:20 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)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:20 INFO - Running setup.py (path:/tmp/pip-lYF2DL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:07:20 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)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:20 INFO - Running setup.py (path:/tmp/pip-Qy7oz2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:20 INFO - Running setup.py (path:/tmp/pip-BVS7wB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:07:20 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)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:20 INFO - Running setup.py (path:/tmp/pip-vpSePj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:07:20 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)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:20 INFO - Running setup.py (path:/tmp/pip-Loa_xB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:07:20 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)) 07:07:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:20 INFO - Running setup.py (path:/tmp/pip-7Oh63c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:07:20 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)) 07:07:20 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)) 07:07:20 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)) 07:07:20 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)) 07:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 07:07:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07: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 07:07:22 INFO - Downloading blessings-1.5.1.tar.gz 07:07:22 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 07:07:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:07:22 INFO - Installing collected packages: blessings 07:07:22 INFO - Running setup.py install for blessings 07:07:22 INFO - Successfully installed blessings 07:07:22 INFO - Cleaning up... 07:07:22 INFO - Return code: 0 07:07:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:07:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:22 INFO - Reading from file tmpfile_stdout 07:07:22 INFO - Current package versions: 07:07:22 INFO - argparse == 1.2.1 07:07:22 INFO - blessings == 1.5.1 07:07:22 INFO - blobuploader == 1.2.4 07:07:22 INFO - docopt == 0.6.1 07:07:22 INFO - manifestparser == 1.1 07:07:22 INFO - mozInstall == 1.12 07:07:22 INFO - mozcrash == 0.16 07:07:22 INFO - mozdebug == 0.1 07:07:22 INFO - mozdevice == 0.48 07:07:22 INFO - mozfile == 1.2 07:07:22 INFO - mozhttpd == 0.7 07:07:22 INFO - mozinfo == 0.9 07:07:22 INFO - mozleak == 0.1 07:07:22 INFO - mozlog == 3.1 07:07:22 INFO - moznetwork == 0.27 07:07:22 INFO - mozprocess == 0.22 07:07:22 INFO - mozprofile == 0.28 07:07:22 INFO - mozrunner == 6.11 07:07:22 INFO - mozscreenshot == 0.1 07:07:22 INFO - mozsystemmonitor == 0.0 07:07:22 INFO - moztest == 0.7 07:07:22 INFO - mozversion == 1.4 07:07:22 INFO - psutil == 3.1.1 07:07:22 INFO - requests == 1.2.3 07:07:22 INFO - wsgiref == 0.1.2 07:07:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:07:22 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')]} 07:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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')]} 07:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:22 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 07:07:22 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 07:07:22 INFO - Using env: {'DISPLAY': ':0', 07:07:22 INFO - 'HOME': '/home/cltbld', 07:07:22 INFO - 'LANG': 'en_US.UTF-8', 07:07:22 INFO - 'LANGUAGE': 'en_US:en', 07:07:22 INFO - 'LOGNAME': 'cltbld', 07:07:22 INFO - 'MAIL': '/var/mail/cltbld', 07:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:22 INFO - 'MOZ_NO_REMOTE': '1', 07:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:22 INFO - 'NO_EM_RESTART': '1', 07:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:22 INFO - 'SHELL': '/bin/bash', 07:07:22 INFO - 'SHLVL': '1', 07:07:22 INFO - 'TERM': 'linux', 07:07:22 INFO - 'TMOUT': '86400', 07:07:22 INFO - 'USER': 'cltbld', 07:07:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:22 INFO - '_': '/tools/buildbot/bin/python'} 07:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 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)) 07:07:22 INFO - Cleaning up... 07:07:22 INFO - Return code: 0 07:07:22 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:07:22 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')]} 07:07:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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')]} 07:07:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:22 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:22 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 07:07:22 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 07:07:22 INFO - Using env: {'DISPLAY': ':0', 07:07:22 INFO - 'HOME': '/home/cltbld', 07:07:22 INFO - 'LANG': 'en_US.UTF-8', 07:07:22 INFO - 'LANGUAGE': 'en_US:en', 07:07:22 INFO - 'LOGNAME': 'cltbld', 07:07:22 INFO - 'MAIL': '/var/mail/cltbld', 07:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:22 INFO - 'MOZ_NO_REMOTE': '1', 07:07:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:22 INFO - 'NO_EM_RESTART': '1', 07:07:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:22 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:22 INFO - 'SHELL': '/bin/bash', 07:07:22 INFO - 'SHLVL': '1', 07:07:22 INFO - 'TERM': 'linux', 07:07:22 INFO - 'TMOUT': '86400', 07:07:22 INFO - 'USER': 'cltbld', 07:07:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:22 INFO - '_': '/tools/buildbot/bin/python'} 07:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:23 INFO - Downloading/unpacking jsonschema 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:23 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 07:07:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:07:24 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 07:07:24 INFO - Downloading/unpacking functools32 (from jsonschema) 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 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 07:07:24 INFO - Downloading functools32-3.2.3-2.tar.gz 07:07:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:07:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:07:25 INFO - warning: no files found matching '*.txt' 07:07:25 INFO - no previously-included directories found matching 'build' 07:07:25 INFO - no previously-included directories found matching 'dist' 07:07:25 INFO - no previously-included directories found matching '.git*' 07:07:25 INFO - Installing collected packages: jsonschema, functools32 07:07:25 INFO - Running setup.py install for functools32 07:07:25 INFO - warning: no files found matching '*.txt' 07:07:25 INFO - no previously-included directories found matching 'build' 07:07:25 INFO - no previously-included directories found matching 'dist' 07:07:25 INFO - no previously-included directories found matching '.git*' 07:07:25 INFO - Successfully installed jsonschema functools32 07:07:25 INFO - Cleaning up... 07:07:25 INFO - Return code: 0 07:07:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:07:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:07:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:07:25 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 0x7fcac777bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b08630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', '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 07:07:25 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 07:07:25 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 07:07:25 INFO - Using env: {'DISPLAY': ':0', 07:07:25 INFO - 'HOME': '/home/cltbld', 07:07:25 INFO - 'LANG': 'en_US.UTF-8', 07:07:25 INFO - 'LANGUAGE': 'en_US:en', 07:07:25 INFO - 'LOGNAME': 'cltbld', 07:07:25 INFO - 'MAIL': '/var/mail/cltbld', 07:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:25 INFO - 'MOZ_NO_REMOTE': '1', 07:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:25 INFO - 'NO_EM_RESTART': '1', 07:07:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:25 INFO - 'SHELL': '/bin/bash', 07:07:25 INFO - 'SHLVL': '1', 07:07:25 INFO - 'TERM': 'linux', 07:07:25 INFO - 'TMOUT': '86400', 07:07:25 INFO - 'USER': 'cltbld', 07:07:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:25 INFO - '_': '/tools/buildbot/bin/python'} 07:07:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:07:25 INFO - Downloading/unpacking flake8 07:07:25 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 07:07:25 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 07:07:25 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 07:07:25 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 07:07:25 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 07:07:25 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 07:07:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:07:27 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 07:07:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:07:27 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 07:07:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 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 07:07:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:07:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:07:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:27 INFO - no previously-included directories found matching 'docs/_build' 07:07:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:07:27 INFO - Running setup.py install for pep8 07:07:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:27 INFO - no previously-included directories found matching 'docs/_build' 07:07:27 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:07:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:07:28 INFO - Cleaning up... 07:07:28 INFO - Return code: 0 07:07:28 INFO - Running post-action listener: _resource_record_post_action 07:07:28 INFO - Running post-action listener: _start_resource_monitoring 07:07:28 INFO - Starting resource monitoring. 07:07:28 INFO - ##### 07:07:28 INFO - ##### Running install step. 07:07:28 INFO - ##### 07:07:28 INFO - Running pre-action listener: _resource_record_pre_action 07:07:28 INFO - Running main action method: install 07:07:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:07:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:07:28 INFO - Reading from file tmpfile_stdout 07:07:28 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:07:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:07:28 INFO - Reading from file tmpfile_stdout 07:07:28 INFO - Output received: 07:07:28 INFO - Usage: mozinstall [options] installer 07:07:28 INFO - Options: 07:07:28 INFO - -h, --help show this help message and exit 07:07:28 INFO - -d DEST, --destination=DEST 07:07:28 INFO - Directory to install application into. [default: 07:07:28 INFO - "/builds/slave/test-pgo"] 07:07:28 INFO - --app=APP Application being installed. [default: firefox] 07:07:28 INFO - mkdir: /builds/slave/test-pgo/build/application 07:07:28 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'] 07:07:28 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 07:07:44 INFO - Reading from file tmpfile_stdout 07:07:44 INFO - Output received: 07:07:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:07:44 INFO - Running post-action listener: _resource_record_post_action 07:07:44 INFO - ##### 07:07:44 INFO - ##### Running run-tests step. 07:07:44 INFO - ##### 07:07:44 INFO - Running pre-action listener: _resource_record_pre_action 07:07:44 INFO - Running main action method: run_tests 07:07:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:07:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:07:44 INFO - Python 2.7.3 07:07:44 INFO - Return code: 0 07:07:44 INFO - grabbing minidump binary from tooltool 07:07:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:44 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 0x1b99840>, '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 0x1b066b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b06b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:07:44 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 07:07:44 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 07:07:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:44 INFO - Return code: 0 07:07:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:07:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:07:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:07:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:07:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:07:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:07:45 INFO - Return code: 0 07:07:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 07:07:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 07:07:45 INFO - Using env: {'DISPLAY': ':0', 07:07:45 INFO - 'HOME': '/home/cltbld', 07:07:45 INFO - 'LANG': 'en_US.UTF-8', 07:07:45 INFO - 'LANGUAGE': 'en_US:en', 07:07:45 INFO - 'LOGNAME': 'cltbld', 07:07:45 INFO - 'MAIL': '/var/mail/cltbld', 07:07:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:45 INFO - 'MOZ_NO_REMOTE': '1', 07:07:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:45 INFO - 'NO_EM_RESTART': '1', 07:07:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:07:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:07:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:07:45 INFO - 'SHELL': '/bin/bash', 07:07:45 INFO - 'SHLVL': '1', 07:07:45 INFO - 'TERM': 'linux', 07:07:45 INFO - 'TMOUT': '86400', 07:07:45 INFO - 'USER': 'cltbld', 07:07:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008', 07:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:45 INFO - '_': '/tools/buildbot/bin/python'} 07:07:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 07:07:45 INFO - mozversion application_buildid: 20160119043043 07:07:45 INFO - mozversion application_changeset: b67316254602a63bf4e568198a5c7d3288a9db27 07:07:45 INFO - mozversion application_display_name: Nightly 07:07:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:45 INFO - mozversion application_name: Firefox 07:07:45 INFO - mozversion application_remotingname: firefox 07:07:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:07:45 INFO - mozversion application_vendor: Mozilla 07:07:45 INFO - mozversion application_version: 46.0a1 07:07:45 INFO - mozversion platform_buildid: 20160119043043 07:07:45 INFO - mozversion platform_changeset: b67316254602a63bf4e568198a5c7d3288a9db27 07:07:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:07:45 INFO - mozversion platform_version: 46.0a1 07:07:45 INFO - using testdate: 1453216065 07:07:45 INFO - actual date: 1453216065 07:07:45 INFO - starting webserver on 'localhost:47096' 07:07:45 INFO - SUITE-START | Running 3 tests 07:07:45 INFO - TEST-START | dromaeo_css 07:07:45 INFO - operating with platform_type : linux_ 07:07:45 INFO - Initialising browser for dromaeo_css test... 07:07:45 INFO - TEST-INFO | started process 3396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyXK5US/profile http://localhost:47096/getInfo.html) 07:07:49 INFO - PROCESS | 3396 | __metrics Screen width/height:1600/1200 07:07:49 INFO - PROCESS | 3396 | colorDepth:24 07:07:49 INFO - PROCESS | 3396 | Browser inner width/height: 1024/697 07:07:49 INFO - PROCESS | 3396 | __metrics 07:07:49 INFO - PROCESS | 3396 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:07:49 INFO - PROCESS | 3396 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:50 INFO - TEST-INFO | 3396: exit 0 07:07:50 INFO - Browser initialized. 07:07:50 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:50 INFO - TEST-INFO | started process 3491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyXK5US/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:08:01 INFO - PROCESS | 3491 | RSS: Main: 149463040 07:08:01 INFO - PROCESS | 3491 | 07:08:53 INFO - PROCESS | 3491 | 1453216133633 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] 07:11:02 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47096/tests/dromaeo/cssquery-ext.html) 07:11:03 INFO - PROCESS | 3491 | RSS: Main: 262725632 07:11:03 INFO - PROCESS | 3491 | 07:14:05 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-ext.html (next: http://localhost:47096/tests/dromaeo/cssquery-jquery.html) 07:14:06 INFO - PROCESS | 3491 | RSS: Main: 237039616 07:14:06 INFO - PROCESS | 3491 | 07:17:08 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47096/tests/dromaeo/cssquery-mootools.html) 07:17:08 INFO - PROCESS | 3491 | RSS: Main: 235761664 07:17:08 INFO - PROCESS | 3491 | 07:20:10 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47096/tests/dromaeo/cssquery-prototype.html) 07:20:11 INFO - PROCESS | 3491 | RSS: Main: 214151168 07:20:11 INFO - PROCESS | 3491 | 07:23:13 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47096/tests/dromaeo/cssquery-yui.html) 07:23:14 INFO - PROCESS | 3491 | RSS: Main: 216936448 07:23:14 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | Cycle 1(1): loaded http://localhost:47096/tests/dromaeo/cssquery-yui.html (next: http://localhost:47096/tests/dromaeo/cssquery-dojo.html) 07:26:17 INFO - PROCESS | 3491 | RSS: Main: 288772096 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | __start_tp_report 07:26:17 INFO - PROCESS | 3491 | _x_x_mozilla_page_load 07:26:17 INFO - PROCESS | 3491 | _x_x_mozilla_page_load_details 07:26:17 INFO - PROCESS | 3491 | |i|pagename|runs| 07:26:17 INFO - PROCESS | 3491 | |0;dojo.html;3161.22549975256;3197.2166819129316;3249.090254728677;3251.691089346513;3281.73746100312;5192.454792246807;5255.132903070993;5262.973685131574;5299.682019078858;5308.734563271841;5221.425643179247;5279.155335146377;5302.125149350362;5306.151015837467;5306.469353064692;4795.376601041859;4811.807527698897;4825.975870120645;4888.755562221892;4897.51024897511;4756.6432517561325;4929.556339929406;4950.108980383529;4974.527419895104;5025.949740502585;4754.7147171169845;4823.831165909176;4832.661713680044;4839.564439200489;4862.149123903303;4833.347498087784;4851.151048566487;4857.708537487727;4864.7324397158145;4891.486393928657;4782.306565547976;4847.321375007502;4864.78108485119;4879.048585525824;4882.902341953141;5089.949100508985;5156.767945442464;5199.740012999335;5207.218917162418;5250.579953603703;5696.031674615326;5705.4294570543025;5708.514776244025;5714.200011998323;5717.685527295997;5615.1857980592995;5723.713814309268;5730.083186690152;5730.312362516483;5730.914036289459;5294.7617357219015;5295.152775555931;5364.436734142937;5379.462053794628;5380.973095134499;5870.64776113426;5885.705714714247;5916.970415147896;5929.881402371929;5947.434993675594;5667.688277144714;5668.801591944262;5674.0637794764225;5677.829665110054;5678.943210567924;5624.353199382123;5625.071863142535;5687.090065589568;5716.056850619684;5735.8566035849435;5675.574331925122;5677.432256774289;5683.460071293303;5684.857878553069;5685.800996965087;5635.774569017275;5668.603197776116;5669.376368599451;5674.829755107354;5685.346185188673;4317.158154159909;4329.415528903621;4372.846950356722;4378.190034843564;4380.7371557706;3898.7855667938534;3948.289307924601;3951.7826519541127;3966.424868394067;3997.420374045805;5254.553362964114;5286.9471305287225;5288.471152884681;5292.788288468495;5313.468653134733;5574.526165275997;5659.462351076641;5662.122371032497;5665.80169694067;5672.14917762339;5288.576913846883;5313.335833020872;5330.733463326818;5336.599755018389;5372.838814835562;4765.380500534978;4766.880827979259;4817.710937343771;4818.277258411266;4857.514248575185;5848.619839710405;5858.414158584107;5876.706164691834;5954.3152537458745;5959.791407300723;5687.800926967537;5699.173619825019;5699.430056994267;5702;5740.51205647508;5911.142884281841;5913.526917846476;5914.556408269311;5916.290045194604;5917.497012753965;5483.314585676791;5564.777408903598;5588.944110558842;5660.235868157911;5737.8565535861935;5720.885582288248;5753.194552762533;5756.539476841759;5788.363280039276;5803.65178089316;5597.3003374578175;5604.355499117653;5616.747246374005;5616.803411880564;5618.269624948731;5458.4814442627885;5548.361938377138;5549.7780088796;5581.218629391969;5603;5441.102218133963;5470.124780035176;5473.863153421196;5475.09660905946;5505.752241149078;5570.526505246938;5589;5594.916076258778;5600.299962504687;5627.43725627434;5340.279062326536;5437.945620543744;5447.237386765777;5489.5608351331;5505.339359276913 07:26:17 INFO - PROCESS | 3491 | |1;ext.html;525.6609486880959;530.7372850439033;533.2321457101773;548.9670619762815;552.5193082018644;28380.85809570952;28744.85627571862;28775.28061798456;28869.27826804331;28888.277793055157;36913.077173070684;37284.81357593208;37336.813315933454;37354.25291494175;37374;8304.626291816852;8478.194571515727;8478.915210847905;8484.278836298921;8488.74533763988;8333.374996875229;8444.451110677817;8458.450200736963;8461.53461559614;8463.576821158917;8463.153684631518;8515;8527.403081784278;8539.316854651614;8541.530215838126;8394.706185283516;8446.197611226986;8458;8458.577071146417;8467.915320846774;8365.498070115751;8439.95780021096;8644.178803013703;8654.09132041133;8663.696770612998;40420.79789601063;40498.39252411216;40686;40688.38967415491;40704.59295407037;3000.1899487138567;3052.542118682193;3301.8349082546015;3354.077628652116;3969.0591548180714;30562.847185764153;30959.845200774078;31181.37637247265;31559.36881262385;32086.679133208603;3903.902402439933;3937.27160475313;3991.4012898065234;4022.517297924268;4108.506979162519;265003;265536;266143;266752;266935;51759;52552.474475254756;52582.21126683103;58873.705631472425;59405.70297148487;48353.51646483561;64870.35129648643;66322.33677663162;66448.66775666091;66593;14464.421423142956;14660.85339146595;14782.334794934253;14795.260236988108;14798.408063677332;11044.226904116635;11269.605563805228;11270.267432616854;11273.718157045976;11277.097832173406;17851.37520186787;18308.176132074088;20633;21250.043748031374;21344;7255.23819998903;7473.925260747432;7506.13679426862;7599.696012159452;7618;902.2376092202079;904.6517090920044;956.8995255498212;979.9559019844124;1064.8722153341648;27040.86479567629;27476.45047099087;27635.30911727223;27826.3043423912;30640;943.9811203775886;951.6621599332137;960.1023043454393;998.9500524973722;1067.066316972649;13318.601546837637;13554.661133471545;13557.28854229158;13698;13707.725845483035;245627;246103;247449;247738;248564;53639.73180134152;54071;54265.72867135639;54340.09809656643;54354;1204.3917821500086;1231.5504840733067;1240.7208378115033;1256.830327905721;1259.6095210484596;26348.8682556586;27115.457690845677;27457.725422745516;27609.51514363717;27691.723082768913;45242.773786130856;45382;45412;45473.317900232185;45479.772601136785;234235;237861;238219;291349;292021;28150.43699126047;32281.35437291194;32681;32692.182695432806;33040.83479582587;38869;39287.803560982014;39474.210515790095;39968.20063598653;40138.57782754745;34952.82523587366;35995.1001224961;36003.81998089993;36061.63938360583;36691.63308366989;31136;35250;36214.4567831488;36295.818520907225;36358.636413635526;32983.17542061468;33261.83369083236;33440;33557.83221083879;33641.3271734559;29849.95525156609;32409;32735.83632081824;32783;32798;24285.63571546393;24696;24747.752522475264;25007.374815629755;25088.121915732863 07:26:17 INFO - PROCESS | 3491 | |2;jquery.html;365.06361183564155;367.05849496042646;368.68845825277646;369.6432942210767;371.5058971567815;14113.294335283246;14238.430462781476;15616.375344986202;16375.344986200553;17198;10783.191260655443;11113.388763617997;16710.415135470263;17018.48944531666;17053.14734263288;4716.339712440261;4850.126977144113;4853.029394121172;4855.975720121412;4863.951360486385;3791.317562838688;3916.040570060325;4763.54746299101;5170.508801663836;5362.51737343639;5164.715940623264;5330.173823057413;5350.8127215547465;5354.089804733205;5375.43557926418;5327.174287985349;5332.573394128461;5361.169018802092;5365.248865158842;5379.085555455582;5039.21892106724;5122.052420302256;5149.485051494858;5301.416844147141;5301.496357845998;19412.320568780025;19464.124114414884;19977.500562485908;20187.89906050475;20222.19111235549;1993.401979406187;2030.3604364625096;2107.3783233946024;2151.408362700254;2188.9014994325134;9149.176574108362;9459.19596834263;9519.524023798782;9620;9684.08001239881;1796.362291386552;1811.4022372617005;1894.393793985925;1991.7908619595023;2033.095272603692;40026.399604005965;40936.79531602323;52710.47289527094;55057.724711376584;55532.72233638846;9667.661631842851;9967.850482242773;10036.447995360326;10055.346402483816;10075.647352342632;13248.536301229411;13267.469301227842;13269.800952985714;13272.336383180802;13273.336333183302;6826.692798823966;6844.110265665531;6891.241963384024;6976.825579360455;7004.544704594185;6242.687865606701;6283.937160628335;6367.681615919186;6507.772227971998;6525.836854078686;4444.911101777946;4475.082608065339;4495.797689103998;4498.527654596286;4526.728396296233;1715.2195750933295;1770.3095792640881;1775.4851093182833;1838.1821534842074;1865.2352535460395;812.1999830167281;842.0737189092072;843.5908584336592;929.8930622978309;946.0303189231093;15777.211139442981;16223.26995285215;16276.26756795947;16621.0858402789;16637.750433743502;849.8937632795901;879.9516026618469;901.9864702029474;947.7772723409993;984.9310548261697;9183;9454.763630909283;9464.621415143318;9494.478331938037;9584.808303834025;424309;449770;488515;495696;495735;68753;69032;69947.65026174836;70470.71469639798;70564;1078.8273876179774;1083.967480975572;1127.1602656021316;1135.8466607008113;1139.9145064120223;14426.278686065865;14652.194129322563;14677.779833302722;14716.484923027643;14903.403863845324;31957;32089;32089.518657219694;32386.83806580952;33363.666363337026;40922.59077409307;41792.58207417887;42080.78959605305;42235.36646950237;42694;7078.43372530186;7160.641967901688;7233.204347521663;7349.30181632744;7413.703451861865;9375.812483750151;10232.693019209435;10978.945105274423;11275.66173014811;11471.942640286745;9146.496942668216;9211.907880921373;9532.666356677482;9799.951000244953;9978.351407158512;9265.490398027903;9376;9612.423254604746;9647.421154730739;9745.415275083518;8965.731028069169;9734.561944712646;9928.156106731009;9978.800423991624;10108;5778.913316300343;7072;7244.529105608119;7439.256074392518;7495.396864891764;8541.701040463555;9138.31462640318;10023.348482348623;10075.34510256831;10122.544485498023 07:26:17 INFO - PROCESS | 3491 | |3;mootools.html;1311.9672008199789;1450.9274536273185;1465.033078168409;1606.3092870065875;1773.8137495562958;6904.8964265536;7652.158262591118;7783.805404864881;7809.9609501952555;7815.570143642098;7407.703691852319;7655.234476552342;7658.042744656918;7663;7665.885011724815;2011.5976804639058;2051.2205361962433;2231.230225572175;2290.862548247102;2317.2353123469215;2282.543491301738;2285.1773361589812;2287.4738810073695;2287.885605719716;2287.9084836606517;2214.3135627955303;2284.7486776454575;2285.2116019973164;2286.3483907086484;2290.198430549311;2260.1750361118156;2270.2054281001683;2306.7116610423695;2324.6164382876805;2327.1622216002224;2262.6492893601517;2277.0664027748708;2283.292179424367;2297.7702229777055;2305.4121199094293;7771;7818.726344577969;7834.725784597512;7842.568658723768;7857.0964339101165;4614.630829533629;4718.669693121483;4725.574698277172;4755.35802666639;4760.500147484534;3109.8134111953354;3123.0786917859286;3124.7830011804745;3149.3228955774616;3200.8239546824916;961.2982522758356;990.1633120013577;995.1044060345674;1011.7066050845247;1046.9895301046968;10384.844227336596;10443.112335451497;10465.372077675363;10471.68584942453;10479.47602619866;4195.098053918422;4253.191893540217;4262.531121576624;4292.227399068198;4323.6757243206885;8907.064758200426;8916.910830891738;8942.955285223532;8946.284297256203;8949.239314658196;4748.596369308579;4792.2092854678585;4796.496367881322;4799.616030717534;4805.3512775774825;4375.978120109379;4390.53899340571;4393.231184542692;4395.758233297135;4410.5368936261875;3406.8977930662118;3475.7740746851373;3529.135361836315;3576.964230357715;3585.8027808470265;1128.424503503203;1135.4890299365318;1135.8864113588575;1140.6121918547733;1145.524607287983;1204.7771162334996;1258.3205069262679;1277.770001399757;1323.5764555342198;1341.8255626768457;7133.750318738819;7180.389666878269;7231.529950553302;7243.855122897513;7255.383292420203;1091.5961094395125;1092.6230450494568;1099.4228030284005;1106.833974903771;1117.6144230240716;5789.536837053026;5897.941020589825;5913.349531551526;5922.940770592325;5925.022371308772;9578.9042109578;9590.760230994141;9759.26805489591;9856.802863942681;9862.556184971694;9674.806503869882;9713.660021899199;9731;9731.610735570639;9735.70792876215;7211.639418029077;7359.1192235260205;7418.517796343221;7504.774856754306;7505.4746167767735;7252.818679533054;7259.092613423322;7263.564186148848;7271.236520165518;7313.780586582411;8151;8300.70947516834;8510.404271701169;8519.95740021296;8540.231379175904;8547.61535730906;8561.743147705578;8714.172153645393;8744.169303916373;8744.562771861254;7124.216336203117;7279.526830755984;7281.089863767029;7283.344498995116;7294.416446684359;6816.761413350708;6975.476839236976;7243.275672432715;7448.813779655552;7500.9249907500225;6913.827154321182;7124;7128.679209435484;7170.462215333767;7179.641017948978;6937.722491100501;7022.964885175541;7043.647817608997;7089;7164.928350716426;6673.532852700265;6949.200841903245;6987.441004719509;6993.650317484004;6996.825079373057;6300.401461861115;6368.108464814837;6368.554201205871;6378.649174295459;6415.1981002374705;6480.254770701241;6507.772227971998;6547.443467305142;6549.377809108127;6549.639769812706 07:26:17 INFO - PROCESS | 3491 | |4;prototype.html;324.4030982991296;325.86150885873496;333.3233535922079;334.3013102615533;339.21641009268575;5714.657120572769;5851.912221316678;5875.647461152334;5923.674197919113;5928.1404196391495;5665.688387138705;5792.073268277077;5815.38938411466;5846;5856.150858125569;4454.398656181423;4473.284274516078;4473.351364052227;4485.416895803549;4496.213162696515;4303.741775493465;4432.091421258634;4486.596206341429;4498.415206023213;4500.639948804088;4398.494173170078;4491.393661855656;4501.369808226835;4504.954950450503;4519.774011299438;4508.684392092522;4513.661475389359;4518.52555481673;4519.050999290153;4520.344550040242;3975.4831871856472;3976.363781794928;3976.3836605325932;3987.521497420299;3990.700697447674;5485.040117979377;5571.804986825442;5591.776328946838;5609.943900560983;5617.719114044281;5238.5023422774775;5238.81664141757;5246.265522826808;5254.133068043769;5256.92114618281;6167.537434692416;6179.907301390483;6189.6286222826775;6191.783287584913;6194.380561943814;4155.189738001091;4207.64235040022;4249.553796851348;4293.828246870153;4392.34114882767;6432.292447830735;6467.159269294962;6480.416762491398;6482.611043337415;6490.902636460457;4481.148581769454;4483.417155769795;4487.259602165672;4490.057088011554;4490.079533695584;4497.707649002804;4504.324351347324;4510.661700372485;4510.797014134372;4519.525449827786;4975.4527002029745;5099.158638824627;5107.284980102789;5109.233614957786;5122.052420302256;6265.8746825063245;6273.8745225095245;6278.15244941927;6279.686015699197;6280.2777680566405;1556.7587024011295;1571.08091766318;1572.0567659404267;1573.590866374728;1573.9842601574067;1022.6420752736632;1025.0671888581505;1026.1739299863682;1037.64719995202;1047.8009178256107;5893.616914900518;5901.0558310670085;5902.557308201902;5908.497777688945;5914.4381283777975;6429.935700642934;6439.291677915426;6448.742050318028;6451.806445806634;6461.741530338733;5903.203067585907;5907.645541267538;5911.527077833763;5913.290405151323;5914.792982245601;3378.037259381114;3482.7736197147105;3487.6861082502187;3492.371373152806;3502.0894567412656;6624.337566243434;6633.6019838809825;6636.070950066995;6638.701258443285;6640.937450007976;6641.800745977628;6649.867002660017;6653.301403352675;6653.966730166415;6659;6566.080748695186;6743.932560674429;6752.189737231465;6753.15585551806;6755.763548275787;6494.9025764612625;6500.934990650033;6504.707288172138;6505.31694172124;6509.1863517060365;6146.907796382969;6170.845728856814;6305.90541141874;6374.26695929974;6375.043743438521;6678.799636010927;6688.699008544724;6696.531242812956;6698.22970358415;6702.798916032527;4271.402003719544;4289.1850548395705;4293.763842988666;4296.785160741888;4302.956970430256;6309.621422714652;6452.483801295979;6462.159919210472;6465.64438955862;6477.838054048687;6304.464120549805;6308.369163083655;6315.747370105144;6316.463100636313;6318.557700961072;6296.275928268308;6298.779542715983;6305.5270854687;6306.243250809932;6307.337729538516;5996.4902983245165;6161.476274516716;6201.751929922752;6203.534734894811;6294.464970477561;6316.7157477914525;6367.713452894538;6369.554131210956;6370.108184854032;6378.170837791243;6194.628322300677;6205.596636218631;6205.844853878689;6208.068789681584;6209.96895015522 07:26:17 INFO - PROCESS | 3491 | |5;yui.html;746.4849254014731;803.9829615536346;856.0669414658048;870.2602787630515;878.0736323179044;13077.411516481758;13232.27222502762;13257.933710331446;13261.8010729839;13267.336633168326;11724.941375293132;12127.332996685178;12571.497140114385;12595.3072581008;12639.494420223204;792.8850316704074;809.7975506123469;810.1574362662824;811.9512829230235;812.7683610171102;800.0679208721862;810.3233799777194;812.6180695073335;812.7236739508566;812.8943237379133;854.2781349759443;860.475110182788;862.7756783236341;863.1368631368631;863.5250612163317;849.7705619482736;852.7868032991752;854.8162145138825;855.055164043729;855.6919508976795;630.7319389259546;631.8894193516117;631.936806319369;633.5438484291303;633.8605506788499;12158.270503769802;12169.452374643073;12171.33057681827;12193.756124877453;12200.450979705935;11038.227324087316;11251.09991200702;11665.883341166564;12312.938435307855;12452.937735311356;9836.606535738561;10161.237907156992;10209.336393134423;10226.897731022744;10323.2257580681;3502.124468882779;3507.4914137450182;3556.2176321209295;3627.546556680415;3656.6526180012856;44360.11279774419;45240;45694.54305456936;50382.49617503815;50456.495435045545;9964.701058968243;10035.304808107767;10152.49237538135;10179.236557258235;10326.277160598836;15805.920970395075;16996.830031699774;17747.201375938115;18350.541236469195;18468;7543.73596924116;7547.0943486781935;7557.659905304275;7564.697412103565;7576.696932122653;3548.0242933193063;3696.7412281140064;4136.379543068504;4189.811458484375;4224.4930608327195;3104.1153271318017;3109.2537790930464;3112.8443577821017;3133.6082989626298;3162.4307624627327;574.7499189263419;579.2296245992903;590.976360945566;595.5414330965219;598.6557729305666;509.7272958966935;512.5104088187504;514.8712821794552;526.2211926349025;591.4469970577524;8292.37807164465;8478.660853565912;8771;8844.646214151362;8975.685850995184;624.4005754475754;667.6428110960612;691.0360047733384;693.2582137113241;693.5214701855704;3948.7433316834313;4067.877963661095;4135.400366946776;4159.396887451363;4191.119864828359;51471;51529.742351288005;52482;52507.47492525026;52578.211326830125;48348.27477587839;51800.74099629553;52031.21953170706;52731;52772.20841687378;42524;43469.17450365716;44612.776936115115;44717.55282447199;45036.54963450324;8249.83500330002;8375.581220938806;8390.958045209734;8407.327413806759;8512.914870851213;31916.52125218077;32923.835380822944;33641.495377569845;36075.639243608275;36083.63916360803;43879.122417552106;43910.34134488049;43957.56042439535;43987.34018989782;44095.55904440914;10559.894401056199;11120.666380008613;11537.82693259585;11842.644720658394;12117.212381195193;11271.267367621078;11778.941105294418;11934;12178.634640960785;12876.098673092794;11197.384143872165;11262.83105753398;11337.773244535229;11390.544378224778;11608.361540115375;11183.384913829817;11432.94283528577;11471.197016209118;11551.306921584732;12162.513499459923;11094.722631934266;11266.098712103176;11481.483333249857;11654.76690466169;11725.941370293094;8926.910730892867;9010;9172.908270917473;9185.770355740893;9281.953590232006;8518.78703032429;8957.910420895969;9215.815683686154;9385.967543570065;9453.621855125994 07:26:17 INFO - PROCESS | 3491 | __end_tp_report 07:26:17 INFO - PROCESS | 3491 | __start_cc_report 07:26:17 INFO - PROCESS | 3491 | _x_x_mozilla_cycle_collect,935 07:26:17 INFO - PROCESS | 3491 | __end_cc_report 07:26:17 INFO - PROCESS | 3491 | __startTimestamp1453217177366__endTimestamp 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | ------- Summary: start ------- 07:26:17 INFO - PROCESS | 3491 | Number of tests: 6 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#0] dojo.html Cycles:165 Average:5289.92 Median:5475.10 stddev:583.71 (10.7%) stddev-sans-first:561.10 07:26:17 INFO - PROCESS | 3491 | Values: 3161.2 3197.2 3249.1 3251.7 3281.7 5192.5 5255.1 5263.0 5299.7 5308.7 5221.4 5279.2 5302.1 5306.2 5306.5 4795.4 4811.8 4826.0 4888.8 4897.5 4756.6 4929.6 4950.1 4974.5 5025.9 4754.7 4823.8 4832.7 4839.6 4862.1 4833.3 4851.2 4857.7 4864.7 4891.5 4782.3 4847.3 4864.8 4879.0 4882.9 5089.9 5156.8 5199.7 5207.2 5250.6 5696.0 5705.4 5708.5 5714.2 5717.7 5615.2 5723.7 5730.1 5730.3 5730.9 5294.8 5295.2 5364.4 5379.5 5381.0 5870.6 5885.7 5917.0 5929.9 5947.4 5667.7 5668.8 5674.1 5677.8 5678.9 5624.4 5625.1 5687.1 5716.1 5735.9 5675.6 5677.4 5683.5 5684.9 5685.8 5635.8 5668.6 5669.4 5674.8 5685.3 4317.2 4329.4 4372.8 4378.2 4380.7 3898.8 3948.3 3951.8 3966.4 3997.4 5254.6 5286.9 5288.5 5292.8 5313.5 5574.5 5659.5 5662.1 5665.8 5672.1 5288.6 5313.3 5330.7 5336.6 5372.8 4765.4 4766.9 4817.7 4818.3 4857.5 5848.6 5858.4 5876.7 5954.3 5959.8 5687.8 5699.2 5699.4 5702.0 5740.5 5911.1 5913.5 5914.6 5916.3 5917.5 5483.3 5564.8 5588.9 5660.2 5737.9 5720.9 5753.2 5756.5 5788.4 5803.7 5597.3 5604.4 5616.7 5616.8 5618.3 5458.5 5548.4 5549.8 5581.2 5603.0 5441.1 5470.1 5473.9 5475.1 5505.8 5570.5 5589.0 5594.9 5600.3 5627.4 5340.3 5437.9 5447.2 5489.6 5505.3 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#1] ext.html Cycles:180 Average:42641.33 Median:36032.73 stddev:67199.19 (186.5%) stddev-sans-first:67313.29 07:26:17 INFO - PROCESS | 3491 | Values: 525.7 530.7 533.2 549.0 552.5 28380.9 28744.9 28775.3 28869.3 28888.3 36913.1 37284.8 37336.8 37354.3 37374.0 8304.6 8478.2 8478.9 8484.3 8488.7 8333.4 8444.5 8458.5 8461.5 8463.6 8463.2 8515.0 8527.4 8539.3 8541.5 8394.7 8446.2 8458.0 8458.6 8467.9 8365.5 8440.0 8644.2 8654.1 8663.7 40420.8 40498.4 40686.0 40688.4 40704.6 3000.2 3052.5 3301.8 3354.1 3969.1 30562.8 30959.8 31181.4 31559.4 32086.7 3903.9 3937.3 3991.4 4022.5 4108.5 265003.0 265536.0 266143.0 266752.0 266935.0 51759.0 52552.5 52582.2 58873.7 59405.7 48353.5 64870.4 66322.3 66448.7 66593.0 14464.4 14660.9 14782.3 14795.3 14798.4 11044.2 11269.6 11270.3 11273.7 11277.1 17851.4 18308.2 20633.0 21250.0 21344.0 7255.2 7473.9 7506.1 7599.7 7618.0 902.2 904.7 956.9 980.0 1064.9 27040.9 27476.5 27635.3 27826.3 30640.0 944.0 951.7 960.1 999.0 1067.1 13318.6 13554.7 13557.3 13698.0 13707.7 245627.0 246103.0 247449.0 247738.0 248564.0 53639.7 54071.0 54265.7 54340.1 54354.0 1204.4 1231.6 1240.7 1256.8 1259.6 26348.9 27115.5 27457.7 27609.5 27691.7 45242.8 45382.0 45412.0 45473.3 45479.8 234235.0 237861.0 238219.0 291349.0 292021.0 28150.4 32281.4 32681.0 32692.2 33040.8 38869.0 39287.8 39474.2 39968.2 40138.6 34952.8 35995.1 36003.8 36061.6 36691.6 31136.0 35250.0 36214.5 36295.8 36358.6 32983.2 33261.8 33440.0 33557.8 33641.3 29850.0 32409.0 32735.8 32783.0 32798.0 24285.6 24696.0 24747.8 25007.4 25088.1 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#2] jquery.html Cycles:180 Average:25060.91 Median:4854.50 stddev:77065.05 (1587.5%) stddev-sans-first:77258.93 07:26:17 INFO - PROCESS | 3491 | Values: 365.1 367.1 368.7 369.6 371.5 14113.3 14238.4 15616.4 16375.3 17198.0 10783.2 11113.4 16710.4 17018.5 17053.1 4716.3 4850.1 4853.0 4856.0 4864.0 3791.3 3916.0 4763.5 5170.5 5362.5 5164.7 5330.2 5350.8 5354.1 5375.4 5327.2 5332.6 5361.2 5365.2 5379.1 5039.2 5122.1 5149.5 5301.4 5301.5 19412.3 19464.1 19977.5 20187.9 20222.2 1993.4 2030.4 2107.4 2151.4 2188.9 9149.2 9459.2 9519.5 9620.0 9684.1 1796.4 1811.4 1894.4 1991.8 2033.1 40026.4 40936.8 52710.5 55057.7 55532.7 9667.7 9967.9 10036.4 10055.3 10075.6 13248.5 13267.5 13269.8 13272.3 13273.3 6826.7 6844.1 6891.2 6976.8 7004.5 6242.7 6283.9 6367.7 6507.8 6525.8 4444.9 4475.1 4495.8 4498.5 4526.7 1715.2 1770.3 1775.5 1838.2 1865.2 812.2 842.1 843.6 929.9 946.0 15777.2 16223.3 16276.3 16621.1 16637.8 849.9 880.0 902.0 947.8 984.9 9183.0 9454.8 9464.6 9494.5 9584.8 424309.0 449770.0 488515.0 495696.0 495735.0 68753.0 69032.0 69947.7 70470.7 70564.0 1078.8 1084.0 1127.2 1135.8 1139.9 14426.3 14652.2 14677.8 14716.5 14903.4 31957.0 32089.0 32089.5 32386.8 33363.7 40922.6 41792.6 42080.8 42235.4 42694.0 7078.4 7160.6 7233.2 7349.3 7413.7 9375.8 10232.7 10978.9 11275.7 11471.9 9146.5 9211.9 9532.7 9800.0 9978.4 9265.5 9376.0 9612.4 9647.4 9745.4 8965.7 9734.6 9928.2 9978.8 10108.0 5778.9 7072.0 7244.5 7439.3 7495.4 8541.7 9138.3 10023.3 10075.3 10122.5 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#3] mootools.html Cycles:180 Average:5480.41 Median:6396.92 stddev:2833.97 (44.3%) stddev-sans-first:2824.60 07:26:17 INFO - PROCESS | 3491 | Values: 1312.0 1450.9 1465.0 1606.3 1773.8 6904.9 7652.2 7783.8 7810.0 7815.6 7407.7 7655.2 7658.0 7663.0 7665.9 2011.6 2051.2 2231.2 2290.9 2317.2 2282.5 2285.2 2287.5 2287.9 2287.9 2214.3 2284.7 2285.2 2286.3 2290.2 2260.2 2270.2 2306.7 2324.6 2327.2 2262.6 2277.1 2283.3 2297.8 2305.4 7771.0 7818.7 7834.7 7842.6 7857.1 4614.6 4718.7 4725.6 4755.4 4760.5 3109.8 3123.1 3124.8 3149.3 3200.8 961.3 990.2 995.1 1011.7 1047.0 10384.8 10443.1 10465.4 10471.7 10479.5 4195.1 4253.2 4262.5 4292.2 4323.7 8907.1 8916.9 8943.0 8946.3 8949.2 4748.6 4792.2 4796.5 4799.6 4805.4 4376.0 4390.5 4393.2 4395.8 4410.5 3406.9 3475.8 3529.1 3577.0 3585.8 1128.4 1135.5 1135.9 1140.6 1145.5 1204.8 1258.3 1277.8 1323.6 1341.8 7133.8 7180.4 7231.5 7243.9 7255.4 1091.6 1092.6 1099.4 1106.8 1117.6 5789.5 5897.9 5913.3 5922.9 5925.0 9578.9 9590.8 9759.3 9856.8 9862.6 9674.8 9713.7 9731.0 9731.6 9735.7 7211.6 7359.1 7418.5 7504.8 7505.5 7252.8 7259.1 7263.6 7271.2 7313.8 8151.0 8300.7 8510.4 8520.0 8540.2 8547.6 8561.7 8714.2 8744.2 8744.6 7124.2 7279.5 7281.1 7283.3 7294.4 6816.8 6975.5 7243.3 7448.8 7500.9 6913.8 7124.0 7128.7 7170.5 7179.6 6937.7 7023.0 7043.6 7089.0 7164.9 6673.5 6949.2 6987.4 6993.7 6996.8 6300.4 6368.1 6368.6 6378.6 6415.2 6480.3 6507.8 6547.4 6549.4 6549.6 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#4] prototype.html Cycles:180 Average:5218.20 Median:5902.88 stddev:1582.20 (26.8%) stddev-sans-first:1543.41 07:26:17 INFO - PROCESS | 3491 | Values: 324.4 325.9 333.3 334.3 339.2 5714.7 5851.9 5875.6 5923.7 5928.1 5665.7 5792.1 5815.4 5846.0 5856.2 4454.4 4473.3 4473.4 4485.4 4496.2 4303.7 4432.1 4486.6 4498.4 4500.6 4398.5 4491.4 4501.4 4505.0 4519.8 4508.7 4513.7 4518.5 4519.1 4520.3 3975.5 3976.4 3976.4 3987.5 3990.7 5485.0 5571.8 5591.8 5609.9 5617.7 5238.5 5238.8 5246.3 5254.1 5256.9 6167.5 6179.9 6189.6 6191.8 6194.4 4155.2 4207.6 4249.6 4293.8 4392.3 6432.3 6467.2 6480.4 6482.6 6490.9 4481.1 4483.4 4487.3 4490.1 4490.1 4497.7 4504.3 4510.7 4510.8 4519.5 4975.5 5099.2 5107.3 5109.2 5122.1 6265.9 6273.9 6278.2 6279.7 6280.3 1556.8 1571.1 1572.1 1573.6 1574.0 1022.6 1025.1 1026.2 1037.6 1047.8 5893.6 5901.1 5902.6 5908.5 5914.4 6429.9 6439.3 6448.7 6451.8 6461.7 5903.2 5907.6 5911.5 5913.3 5914.8 3378.0 3482.8 3487.7 3492.4 3502.1 6624.3 6633.6 6636.1 6638.7 6640.9 6641.8 6649.9 6653.3 6654.0 6659.0 6566.1 6743.9 6752.2 6753.2 6755.8 6494.9 6500.9 6504.7 6505.3 6509.2 6146.9 6170.8 6305.9 6374.3 6375.0 6678.8 6688.7 6696.5 6698.2 6702.8 4271.4 4289.2 4293.8 4296.8 4303.0 6309.6 6452.5 6462.2 6465.6 6477.8 6304.5 6308.4 6315.7 6316.5 6318.6 6296.3 6298.8 6305.5 6306.2 6307.3 5996.5 6161.5 6201.8 6203.5 6294.5 6316.7 6367.7 6369.6 6370.1 6378.2 6194.6 6205.6 6205.8 6208.1 6210.0 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - PROCESS | 3491 | [#5] yui.html Cycles:180 Average:13396.20 Median:44486.44 stddev:15335.48 (34.5%) stddev-sans-first:15349.08 07:26:17 INFO - PROCESS | 3491 | Values: 746.5 804.0 856.1 870.3 878.1 13077.4 13232.3 13257.9 13261.8 13267.3 11724.9 12127.3 12571.5 12595.3 12639.5 792.9 809.8 810.2 812.0 812.8 800.1 810.3 812.6 812.7 812.9 854.3 860.5 862.8 863.1 863.5 849.8 852.8 854.8 855.1 855.7 630.7 631.9 631.9 633.5 633.9 12158.3 12169.5 12171.3 12193.8 12200.5 11038.2 11251.1 11665.9 12312.9 12452.9 9836.6 10161.2 10209.3 10226.9 10323.2 3502.1 3507.5 3556.2 3627.5 3656.7 44360.1 45240.0 45694.5 50382.5 50456.5 9964.7 10035.3 10152.5 10179.2 10326.3 15805.9 16996.8 17747.2 18350.5 18468.0 7543.7 7547.1 7557.7 7564.7 7576.7 3548.0 3696.7 4136.4 4189.8 4224.5 3104.1 3109.3 3112.8 3133.6 3162.4 574.7 579.2 591.0 595.5 598.7 509.7 512.5 514.9 526.2 591.4 8292.4 8478.7 8771.0 8844.6 8975.7 624.4 667.6 691.0 693.3 693.5 3948.7 4067.9 4135.4 4159.4 4191.1 51471.0 51529.7 52482.0 52507.5 52578.2 48348.3 51800.7 52031.2 52731.0 52772.2 42524.0 43469.2 44612.8 44717.6 45036.5 8249.8 8375.6 8391.0 8407.3 8512.9 31916.5 32923.8 33641.5 36075.6 36083.6 43879.1 43910.3 43957.6 43987.3 44095.6 10559.9 11120.7 11537.8 11842.6 12117.2 11271.3 11778.9 11934.0 12178.6 12876.1 11197.4 11262.8 11337.8 11390.5 11608.4 11183.4 11432.9 11471.2 11551.3 12162.5 11094.7 11266.1 11481.5 11654.8 11725.9 8926.9 9010.0 9172.9 9185.8 9282.0 8518.8 8957.9 9215.8 9386.0 9453.6 07:26:17 INFO - PROCESS | 3491 | -------- Summary: end -------- 07:26:17 INFO - PROCESS | 3491 | 07:26:17 INFO - TEST-INFO | 3491: exit 0 07:26:17 INFO - TEST-OK | dromaeo_css | took 1112278ms 07:26:17 INFO - TEST-START | kraken 07:26:17 INFO - operating with platform_type : linux_ 07:26:17 INFO - Initialising browser for kraken test... 07:26:17 INFO - TEST-INFO | started process 3693 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw9Pl9z/profile http://localhost:47096/getInfo.html) 07:26:21 INFO - PROCESS | 3693 | __metrics Screen width/height:1600/1200 07:26:21 INFO - PROCESS | 3693 | colorDepth:24 07:26:21 INFO - PROCESS | 3693 | Browser inner width/height: 1024/697 07:26:21 INFO - PROCESS | 3693 | __metrics 07:26:21 INFO - PROCESS | 3693 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:26:21 INFO - PROCESS | 3693 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:26:22 INFO - TEST-INFO | 3693: exit 0 07:26:22 INFO - Browser initialized. 07:26:22 INFO - Running cycle 1/1 for kraken test... 07:26:22 INFO - TEST-INFO | started process 3774 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw9Pl9z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:34 INFO - PROCESS | 3774 | RSS: Main: 149200896 07:26:34 INFO - PROCESS | 3774 | 07:26:36 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47096/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:37 INFO - PROCESS | 3774 | RSS: Main: 187346944 07:26:37 INFO - PROCESS | 3774 | 07:26:39 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47096/tests/kraken/driver.html?testName=audio-dft) 07:26:40 INFO - PROCESS | 3774 | RSS: Main: 178278400 07:26:40 INFO - PROCESS | 3774 | 07:26:43 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47096/tests/kraken/driver.html?testName=audio-fft) 07:26:44 INFO - PROCESS | 3774 | RSS: Main: 160092160 07:26:44 INFO - PROCESS | 3774 | 07:26:46 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47096/tests/kraken/driver.html?testName=audio-oscillator) 07:26:46 INFO - PROCESS | 3774 | RSS: Main: 164671488 07:26:46 INFO - PROCESS | 3774 | 07:26:48 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:49 INFO - PROCESS | 3774 | RSS: Main: 165294080 07:26:49 INFO - PROCESS | 3774 | 07:26:52 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47096/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:52 INFO - PROCESS | 3774 | RSS: Main: 165019648 07:26:52 INFO - PROCESS | 3774 | 07:26:56 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47096/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:56 INFO - PROCESS | 3774 | RSS: Main: 166969344 07:26:56 INFO - PROCESS | 3774 | 07:26:59 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47096/tests/kraken/driver.html?testName=json-parse-financial) 07:27:00 INFO - PROCESS | 3774 | RSS: Main: 165609472 07:27:00 INFO - PROCESS | 3774 | 07:27:01 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:27:02 INFO - PROCESS | 3774 | RSS: Main: 180191232 07:27:02 INFO - PROCESS | 3774 | 07:27:04 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:27:04 INFO - PROCESS | 3774 | RSS: Main: 177848320 07:27:04 INFO - PROCESS | 3774 | 07:27:06 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:27:07 INFO - PROCESS | 3774 | RSS: Main: 180850688 07:27:07 INFO - PROCESS | 3774 | 07:27:09 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:27:10 INFO - PROCESS | 3774 | RSS: Main: 191832064 07:27:10 INFO - PROCESS | 3774 | 07:27:12 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:27:13 INFO - PROCESS | 3774 | RSS: Main: 188645376 07:27:13 INFO - PROCESS | 3774 | 07:27:14 INFO - PROCESS | 3774 | Cycle 1(1): loaded http://localhost:47096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47096/tests/kraken/driver.html?testName=ai-astar) 07:27:15 INFO - PROCESS | 3774 | RSS: Main: 247414784 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | __start_tp_report 07:27:15 INFO - PROCESS | 3774 | _x_x_mozilla_page_load 07:27:15 INFO - PROCESS | 3774 | _x_x_mozilla_page_load_details 07:27:15 INFO - PROCESS | 3774 | |i|pagename|runs| 07:27:15 INFO - PROCESS | 3774 | |0;ai-astar;111;110;106;111;112;115;113;112;105;113 07:27:15 INFO - PROCESS | 3774 | |1;audio-beat-detection;157;127;148;159;127;153;159;138;174;137 07:27:15 INFO - PROCESS | 3774 | |2;audio-dft;161;160;162;163;162;162;162;162;163;161 07:27:15 INFO - PROCESS | 3774 | |3;audio-fft;73;72;93;102;73;73;74;114;100;73 07:27:15 INFO - PROCESS | 3774 | |4;audio-oscillator;97;96;149;95;97;95;144;96;95;140 07:27:15 INFO - PROCESS | 3774 | |5;imaging-gaussian-blur;110;110;109;110;109;110;109;109;109;110 07:27:15 INFO - PROCESS | 3774 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;145;146 07:27:15 INFO - PROCESS | 3774 | |7;imaging-desaturate;96;96;97;96;96;96;96;95;95;95 07:27:15 INFO - PROCESS | 3774 | |8;json-parse-financial;56;55;55;55;55;55;56;56;55;54 07:27:15 INFO - PROCESS | 3774 | |9;json-stringify-tinderbox;68;68;68;69;68;74;68;68;69;68 07:27:15 INFO - PROCESS | 3774 | |10;stanford-crypto-aes;81;81;81;83;83;82;97;82;84;83 07:27:15 INFO - PROCESS | 3774 | |11;stanford-crypto-ccm;113;114;111;118;120;119;113;117;119;118 07:27:15 INFO - PROCESS | 3774 | |12;stanford-crypto-pbkdf2;139;139;138;140;142;140;140;141;140;139 07:27:15 INFO - PROCESS | 3774 | |13;stanford-crypto-sha256-iterative;65;66;66;66;67;67;67;66;66;68 07:27:15 INFO - PROCESS | 3774 | __end_tp_report 07:27:15 INFO - PROCESS | 3774 | __start_cc_report 07:27:15 INFO - PROCESS | 3774 | _x_x_mozilla_cycle_collect,922 07:27:15 INFO - PROCESS | 3774 | __end_cc_report 07:27:15 INFO - PROCESS | 3774 | __startTimestamp1453217235158__endTimestamp 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | ------- Summary: start ------- 07:27:15 INFO - PROCESS | 3774 | Number of tests: 14 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.12 (2.8%) stddev-sans-first:3.31 07:27:15 INFO - PROCESS | 3774 | Values: 111.0 110.0 106.0 111.0 112.0 115.0 113.0 112.0 105.0 113.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:155.00 stddev:15.37 (9.9%) stddev-sans-first:15.95 07:27:15 INFO - PROCESS | 3774 | Values: 157.0 127.0 148.0 159.0 127.0 153.0 159.0 138.0 174.0 137.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 07:27:15 INFO - PROCESS | 3774 | Values: 161.0 160.0 162.0 163.0 162.0 162.0 162.0 162.0 163.0 161.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#3] audio-fft Cycles:10 Average:84.70 Median:73.00 stddev:15.93 (21.8%) stddev-sans-first:16.32 07:27:15 INFO - PROCESS | 3774 | Values: 73.0 72.0 93.0 102.0 73.0 73.0 74.0 114.0 100.0 73.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:95.50 stddev:23.52 (24.6%) stddev-sans-first:24.45 07:27:15 INFO - PROCESS | 3774 | Values: 97.0 96.0 149.0 95.0 97.0 95.0 144.0 96.0 95.0 140.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:27:15 INFO - PROCESS | 3774 | Values: 110.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:27:15 INFO - PROCESS | 3774 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:27:15 INFO - PROCESS | 3774 | Values: 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 07:27:15 INFO - PROCESS | 3774 | Values: 56.0 55.0 55.0 55.0 55.0 55.0 56.0 56.0 55.0 54.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.96 07:27:15 INFO - PROCESS | 3774 | Values: 68.0 68.0 68.0 69.0 68.0 74.0 68.0 68.0 69.0 68.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:4.79 (5.8%) stddev-sans-first:4.97 07:27:15 INFO - PROCESS | 3774 | Values: 81.0 81.0 81.0 83.0 83.0 82.0 97.0 82.0 84.0 83.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:118.00 stddev:3.16 (2.7%) stddev-sans-first:3.13 07:27:15 INFO - PROCESS | 3774 | Values: 113.0 114.0 111.0 118.0 120.0 119.0 113.0 117.0 119.0 118.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:140.00 stddev:1.14 (0.8%) stddev-sans-first:1.17 07:27:15 INFO - PROCESS | 3774 | Values: 139.0 139.0 138.0 140.0 142.0 140.0 140.0 141.0 140.0 139.0 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - PROCESS | 3774 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.73 07:27:15 INFO - PROCESS | 3774 | Values: 65.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 66.0 68.0 07:27:15 INFO - PROCESS | 3774 | -------- Summary: end -------- 07:27:15 INFO - PROCESS | 3774 | 07:27:15 INFO - TEST-INFO | 3774: exit 0 07:27:16 INFO - TEST-OK | kraken | took 58029ms 07:27:16 INFO - TEST-START | v8_7 07:27:16 INFO - operating with platform_type : linux_ 07:27:16 INFO - Initialising browser for v8_7 test... 07:27:16 INFO - TEST-INFO | started process 4023 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphLVnkp/profile http://localhost:47096/getInfo.html) 07:27:19 INFO - PROCESS | 4023 | __metrics Screen width/height:1600/1200 07:27:19 INFO - PROCESS | 4023 | colorDepth:24 07:27:19 INFO - PROCESS | 4023 | Browser inner width/height: 1024/697 07:27:19 INFO - PROCESS | 4023 | __metrics 07:27:19 INFO - PROCESS | 4023 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:27:19 INFO - PROCESS | 4023 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:27:20 INFO - TEST-INFO | 4023: exit 0 07:27:20 INFO - Browser initialized. 07:27:20 INFO - Running cycle 1/1 for v8_7 test... 07:27:20 INFO - TEST-INFO | started process 4103 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphLVnkp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:27:32 INFO - PROCESS | 4103 | RSS: Main: 150499328 07:27:32 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | Cycle 1(1): loaded http://localhost:47096/tests/v8_7/run.html (next: http://localhost:47096/tests/v8_7/run.html) 07:27:54 INFO - PROCESS | 4103 | RSS: Main: 557588480 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | __start_tp_report 07:27:54 INFO - PROCESS | 4103 | _x_x_mozilla_page_load 07:27:54 INFO - PROCESS | 4103 | _x_x_mozilla_page_load_details 07:27:54 INFO - PROCESS | 4103 | |i|pagename|runs| 07:27:54 INFO - PROCESS | 4103 | |0;Richards;166.55562958027983 07:27:54 INFO - PROCESS | 4103 | |1;DeltaBlue;189.5016107636915 07:27:54 INFO - PROCESS | 4103 | |2;Encrypt;279.4076557697681 07:27:54 INFO - PROCESS | 4103 | |3;Decrypt;5251.308900523561 07:27:54 INFO - PROCESS | 4103 | |4;RayTrace;2042.857142857143 07:27:54 INFO - PROCESS | 4103 | |5;Earley;800 07:27:54 INFO - PROCESS | 4103 | |6;Boyer;12395.061728395061 07:27:54 INFO - PROCESS | 4103 | |7;RegExp;42645.833333333336 07:27:54 INFO - PROCESS | 4103 | |8;Splay;575.0999428897773 07:27:54 INFO - PROCESS | 4103 | |9;NavierStokes;4822.115384615385 07:27:54 INFO - PROCESS | 4103 | __end_tp_report 07:27:54 INFO - PROCESS | 4103 | __startTimestamp1453217274940__endTimestamp 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | ------- Summary: start ------- 07:27:54 INFO - PROCESS | 4103 | Number of tests: 10 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 166.6 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#1] DeltaBlue Cycles:1 Average:189.50 Median:189.50 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 189.5 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 279.4 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 5251.3 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#4] RayTrace Cycles:1 Average:2042.86 Median:2042.86 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 2042.9 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 800.0 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 12395.1 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#7] RegExp Cycles:1 Average:42645.83 Median:42645.83 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 42645.8 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#8] Splay Cycles:1 Average:575.10 Median:575.10 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 575.1 07:27:54 INFO - PROCESS | 4103 | 07:27:54 INFO - PROCESS | 4103 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 07:27:54 INFO - PROCESS | 4103 | Values: 4822.1 07:27:54 INFO - PROCESS | 4103 | -------- Summary: end -------- 07:27:54 INFO - PROCESS | 4103 | 07:27:55 INFO - TEST-INFO | 4103: exit 0 07:27:55 INFO - TEST-OK | v8_7 | took 39709ms 07:27:55 INFO - SUITE-END | took 1210s 07:27:55 INFO - Completed test suite (00:20:10) 07:27:55 INFO - Working with test: dromaeo_css 07:27:55 INFO - Generating results file: dromaeo_css 07:27:55 INFO - Working with test: kraken 07:27:55 INFO - Generating results file: kraken 07:27:55 INFO - javascript benchmark 07:27:55 INFO - Working with test: v8_7 07:27:55 INFO - Generating results file: v8_7 07:27:55 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:55 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 07:27:55 INFO - process_Request line: dromaeo_css 6766.06 graph.html#tests=[[72,1,35]] 07:27:55 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:56 INFO - process_Request line: kraken 1496.60 graph.html#tests=[[232,1,35]] 07:27:56 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:27:56 INFO - process_Request line: v8_7 18860.39 graph.html#tests=[[230,1,35]] 07:27:56 INFO - RETURN: dromaeo_css: 6766.06 07:27:56 INFO - RETURN: kraken: 1496.60 07:27:56 INFO - RETURN: v8_7: 18860.39 07:27:56 INFO - javascript benchmark 07:27:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3161.22549975256, 3197.2166819129316, 3249.090254728677, 3251.691089346513, 3281.73746100312, 5192.454792246807, 5255.132903070993, 5262.973685131574, 5299.682019078858, 5308.734563271841, 5221.425643179247, 5279.155335146377, 5302.125149350362, 5306.151015837467, 5306.469353064692, 4795.376601041859, 4811.807527698897, 4825.975870120645, 4888.755562221892, 4897.51024897511, 4756.6432517561325, 4929.556339929406, 4950.108980383529, 4974.527419895104, 5025.949740502585, 4754.7147171169845, 4823.831165909176, 4832.661713680044, 4839.564439200489, 4862.149123903303, 4833.347498087784, 4851.151048566487, 4857.708537487727, 4864.7324397158145, 4891.486393928657, 4782.306565547976, 4847.321375007502, 4864.78108485119, 4879.048585525824, 4882.902341953141, 5089.949100508985, 5156.767945442464, 5199.740012999335, 5207.218917162418, 5250.579953603703, 5696.031674615326, 5705.4294570543025, 5708.514776244025, 5714.200011998323, 5717.685527295997, 5615.1857980592995, 5723.713814309268, 5730.083186690152, 5730.312362516483, 5730.914036289459, 5294.7617357219015, 5295.152775555931, 5364.436734142937, 5379.462053794628, 5380.973095134499, 5870.64776113426, 5885.705714714247, 5916.970415147896, 5929.881402371929, 5947.434993675594, 5667.688277144714, 5668.801591944262, 5674.0637794764225, 5677.829665110054, 5678.943210567924, 5624.353199382123, 5625.071863142535, 5687.090065589568, 5716.056850619684, 5735.8566035849435, 5675.574331925122, 5677.432256774289, 5683.460071293303, 5684.857878553069, 5685.800996965087, 5635.774569017275, 5668.603197776116, 5669.376368599451, 5674.829755107354, 5685.346185188673, 4317.158154159909, 4329.415528903621, 4372.846950356722, 4378.190034843564, 4380.7371557706, 3898.7855667938534, 3948.289307924601, 3951.7826519541127, 3966.424868394067, 3997.420374045805, 5254.553362964114, 5286.9471305287225, 5288.471152884681, 5292.788288468495, 5313.468653134733, 5574.526165275997, 5659.462351076641, 5662.122371032497, 5665.80169694067, 5672.14917762339, 5288.576913846883, 5313.335833020872, 5330.733463326818, 5336.599755018389, 5372.838814835562, 4765.380500534978, 4766.880827979259, 4817.710937343771, 4818.277258411266, 4857.514248575185, 5848.619839710405, 5858.414158584107, 5876.706164691834, 5954.3152537458745, 5959.791407300723, 5687.800926967537, 5699.173619825019, 5699.430056994267, 5702.0, 5740.51205647508, 5911.142884281841, 5913.526917846476, 5914.556408269311, 5916.290045194604, 5917.497012753965, 5483.314585676791, 5564.777408903598, 5588.944110558842, 5660.235868157911, 5737.8565535861935, 5720.885582288248, 5753.194552762533, 5756.539476841759, 5788.363280039276, 5803.65178089316, 5597.3003374578175, 5604.355499117653, 5616.747246374005, 5616.803411880564, 5618.269624948731, 5458.4814442627885, 5548.361938377138, 5549.7780088796, 5581.218629391969, 5603.0, 5441.102218133963, 5470.124780035176, 5473.863153421196, 5475.09660905946, 5505.752241149078, 5570.526505246938, 5589.0, 5594.916076258778, 5600.299962504687, 5627.43725627434, 5340.279062326536, 5437.945620543744, 5447.237386765777, 5489.5608351331, 5505.339359276913], "unit": "score", "name": "dojo.html", "value": 5252.55454265671}, {"lowerIsBetter": false, "replicates": [525.6609486880959, 530.7372850439033, 533.2321457101773, 548.9670619762815, 552.5193082018644, 28380.85809570952, 28744.85627571862, 28775.28061798456, 28869.27826804331, 28888.277793055157, 36913.077173070684, 37284.81357593208, 37336.813315933454, 37354.25291494175, 37374.0, 8304.626291816852, 8478.194571515727, 8478.915210847905, 8484.278836298921, 8488.74533763988, 8333.374996875229, 8444.451110677817, 8458.450200736963, 8461.53461559614, 8463.576821158917, 8463.153684631518, 8515.0, 8527.403081784278, 8539.316854651614, 8541.530215838126, 8394.706185283516, 8446.197611226986, 8458.0, 8458.577071146417, 8467.915320846774, 8365.498070115751, 8439.95780021096, 8644.178803013703, 8654.09132041133, 8663.696770612998, 40420.79789601063, 40498.39252411216, 40686.0, 40688.38967415491, 40704.59295407037, 3000.1899487138567, 3052.542118682193, 3301.8349082546015, 3354.077628652116, 3969.0591548180714, 30562.847185764153, 30959.845200774078, 31181.37637247265, 31559.36881262385, 32086.679133208603, 3903.902402439933, 3937.27160475313, 3991.4012898065234, 4022.517297924268, 4108.506979162519, 265003.0, 265536.0, 266143.0, 266752.0, 266935.0, 51759.0, 52552.474475254756, 52582.21126683103, 58873.705631472425, 59405.70297148487, 48353.51646483561, 64870.35129648643, 66322.33677663162, 66448.66775666091, 66593.0, 14464.421423142956, 14660.85339146595, 14782.334794934253, 14795.260236988108, 14798.408063677332, 11044.226904116635, 11269.605563805228, 11270.267432616854, 11273.718157045976, 11277.097832173406, 17851.37520186787, 18308.176132074088, 20633.0, 21250.043748031374, 21344.0, 7255.23819998903, 7473.925260747432, 7506.13679426862, 7599.696012159452, 7618.0, 902.2376092202079, 904.6517090920044, 956.8995255498212, 979.9559019844124, 1064.8722153341648, 27040.86479567629, 27476.45047099087, 27635.30911727223, 27826.3043423912, 30640.0, 943.9811203775886, 951.6621599332137, 960.1023043454393, 998.9500524973722, 1067.066316972649, 13318.601546837637, 13554.661133471545, 13557.28854229158, 13698.0, 13707.725845483035, 245627.0, 246103.0, 247449.0, 247738.0, 248564.0, 53639.73180134152, 54071.0, 54265.72867135639, 54340.09809656643, 54354.0, 1204.3917821500086, 1231.5504840733067, 1240.7208378115033, 1256.830327905721, 1259.6095210484596, 26348.8682556586, 27115.457690845677, 27457.725422745516, 27609.51514363717, 27691.723082768913, 45242.773786130856, 45382.0, 45412.0, 45473.317900232185, 45479.772601136785, 234235.0, 237861.0, 238219.0, 291349.0, 292021.0, 28150.43699126047, 32281.35437291194, 32681.0, 32692.182695432806, 33040.83479582587, 38869.0, 39287.803560982014, 39474.210515790095, 39968.20063598653, 40138.57782754745, 34952.82523587366, 35995.1001224961, 36003.81998089993, 36061.63938360583, 36691.63308366989, 31136.0, 35250.0, 36214.4567831488, 36295.818520907225, 36358.636413635526, 32983.17542061468, 33261.83369083236, 33440.0, 33557.83221083879, 33641.3271734559, 29849.95525156609, 32409.0, 32735.83632081824, 32783.0, 32798.0, 24285.63571546393, 24696.0, 24747.752522475264, 25007.374815629755, 25088.121915732863], "unit": "score", "name": "ext.html", "value": 17658.164952386454}, {"lowerIsBetter": false, "replicates": [365.06361183564155, 367.05849496042646, 368.68845825277646, 369.6432942210767, 371.5058971567815, 14113.294335283246, 14238.430462781476, 15616.375344986202, 16375.344986200553, 17198.0, 10783.191260655443, 11113.388763617997, 16710.415135470263, 17018.48944531666, 17053.14734263288, 4716.339712440261, 4850.126977144113, 4853.029394121172, 4855.975720121412, 4863.951360486385, 3791.317562838688, 3916.040570060325, 4763.54746299101, 5170.508801663836, 5362.51737343639, 5164.715940623264, 5330.173823057413, 5350.8127215547465, 5354.089804733205, 5375.43557926418, 5327.174287985349, 5332.573394128461, 5361.169018802092, 5365.248865158842, 5379.085555455582, 5039.21892106724, 5122.052420302256, 5149.485051494858, 5301.416844147141, 5301.496357845998, 19412.320568780025, 19464.124114414884, 19977.500562485908, 20187.89906050475, 20222.19111235549, 1993.401979406187, 2030.3604364625096, 2107.3783233946024, 2151.408362700254, 2188.9014994325134, 9149.176574108362, 9459.19596834263, 9519.524023798782, 9620.0, 9684.08001239881, 1796.362291386552, 1811.4022372617005, 1894.393793985925, 1991.7908619595023, 2033.095272603692, 40026.399604005965, 40936.79531602323, 52710.47289527094, 55057.724711376584, 55532.72233638846, 9667.661631842851, 9967.850482242773, 10036.447995360326, 10055.346402483816, 10075.647352342632, 13248.536301229411, 13267.469301227842, 13269.800952985714, 13272.336383180802, 13273.336333183302, 6826.692798823966, 6844.110265665531, 6891.241963384024, 6976.825579360455, 7004.544704594185, 6242.687865606701, 6283.937160628335, 6367.681615919186, 6507.772227971998, 6525.836854078686, 4444.911101777946, 4475.082608065339, 4495.797689103998, 4498.527654596286, 4526.728396296233, 1715.2195750933295, 1770.3095792640881, 1775.4851093182833, 1838.1821534842074, 1865.2352535460395, 812.1999830167281, 842.0737189092072, 843.5908584336592, 929.8930622978309, 946.0303189231093, 15777.211139442981, 16223.26995285215, 16276.26756795947, 16621.0858402789, 16637.750433743502, 849.8937632795901, 879.9516026618469, 901.9864702029474, 947.7772723409993, 984.9310548261697, 9183.0, 9454.763630909283, 9464.621415143318, 9494.478331938037, 9584.808303834025, 424309.0, 449770.0, 488515.0, 495696.0, 495735.0, 68753.0, 69032.0, 69947.65026174836, 70470.71469639798, 70564.0, 1078.8273876179774, 1083.967480975572, 1127.1602656021316, 1135.8466607008113, 1139.9145064120223, 14426.278686065865, 14652.194129322563, 14677.779833302722, 14716.484923027643, 14903.403863845324, 31957.0, 32089.0, 32089.518657219694, 32386.83806580952, 33363.666363337026, 40922.59077409307, 41792.58207417887, 42080.78959605305, 42235.36646950237, 42694.0, 7078.43372530186, 7160.641967901688, 7233.204347521663, 7349.30181632744, 7413.703451861865, 9375.812483750151, 10232.693019209435, 10978.945105274423, 11275.66173014811, 11471.942640286745, 9146.496942668216, 9211.907880921373, 9532.666356677482, 9799.951000244953, 9978.351407158512, 9265.490398027903, 9376.0, 9612.423254604746, 9647.421154730739, 9745.415275083518, 8965.731028069169, 9734.561944712646, 9928.156106731009, 9978.800423991624, 10108.0, 5778.913316300343, 7072.0, 7244.529105608119, 7439.256074392518, 7495.396864891764, 8541.701040463555, 9138.31462640318, 10023.348482348623, 10075.34510256831, 10122.544485498023], "unit": "score", "name": "jquery.html", "value": 7886.219929870659}, {"lowerIsBetter": false, "replicates": [1311.9672008199789, 1450.9274536273185, 1465.033078168409, 1606.3092870065875, 1773.8137495562958, 6904.8964265536, 7652.158262591118, 7783.805404864881, 7809.9609501952555, 7815.570143642098, 7407.703691852319, 7655.234476552342, 7658.042744656918, 7663.0, 7665.885011724815, 2011.5976804639058, 2051.2205361962433, 2231.230225572175, 2290.862548247102, 2317.2353123469215, 2282.543491301738, 2285.1773361589812, 2287.4738810073695, 2287.885605719716, 2287.9084836606517, 2214.3135627955303, 2284.7486776454575, 2285.2116019973164, 2286.3483907086484, 2290.198430549311, 2260.1750361118156, 2270.2054281001683, 2306.7116610423695, 2324.6164382876805, 2327.1622216002224, 2262.6492893601517, 2277.0664027748708, 2283.292179424367, 2297.7702229777055, 2305.4121199094293, 7771.0, 7818.726344577969, 7834.725784597512, 7842.568658723768, 7857.0964339101165, 4614.630829533629, 4718.669693121483, 4725.574698277172, 4755.35802666639, 4760.500147484534, 3109.8134111953354, 3123.0786917859286, 3124.7830011804745, 3149.3228955774616, 3200.8239546824916, 961.2982522758356, 990.1633120013577, 995.1044060345674, 1011.7066050845247, 1046.9895301046968, 10384.844227336596, 10443.112335451497, 10465.372077675363, 10471.68584942453, 10479.47602619866, 4195.098053918422, 4253.191893540217, 4262.531121576624, 4292.227399068198, 4323.6757243206885, 8907.064758200426, 8916.910830891738, 8942.955285223532, 8946.284297256203, 8949.239314658196, 4748.596369308579, 4792.2092854678585, 4796.496367881322, 4799.616030717534, 4805.3512775774825, 4375.978120109379, 4390.53899340571, 4393.231184542692, 4395.758233297135, 4410.5368936261875, 3406.8977930662118, 3475.7740746851373, 3529.135361836315, 3576.964230357715, 3585.8027808470265, 1128.424503503203, 1135.4890299365318, 1135.8864113588575, 1140.6121918547733, 1145.524607287983, 1204.7771162334996, 1258.3205069262679, 1277.770001399757, 1323.5764555342198, 1341.8255626768457, 7133.750318738819, 7180.389666878269, 7231.529950553302, 7243.855122897513, 7255.383292420203, 1091.5961094395125, 1092.6230450494568, 1099.4228030284005, 1106.833974903771, 1117.6144230240716, 5789.536837053026, 5897.941020589825, 5913.349531551526, 5922.940770592325, 5925.022371308772, 9578.9042109578, 9590.760230994141, 9759.26805489591, 9856.802863942681, 9862.556184971694, 9674.806503869882, 9713.660021899199, 9731.0, 9731.610735570639, 9735.70792876215, 7211.639418029077, 7359.1192235260205, 7418.517796343221, 7504.774856754306, 7505.4746167767735, 7252.818679533054, 7259.092613423322, 7263.564186148848, 7271.236520165518, 7313.780586582411, 8151.0, 8300.70947516834, 8510.404271701169, 8519.95740021296, 8540.231379175904, 8547.61535730906, 8561.743147705578, 8714.172153645393, 8744.169303916373, 8744.562771861254, 7124.216336203117, 7279.526830755984, 7281.089863767029, 7283.344498995116, 7294.416446684359, 6816.761413350708, 6975.476839236976, 7243.275672432715, 7448.813779655552, 7500.9249907500225, 6913.827154321182, 7124.0, 7128.679209435484, 7170.462215333767, 7179.641017948978, 6937.722491100501, 7022.964885175541, 7043.647817608997, 7089.0, 7164.928350716426, 6673.532852700265, 6949.200841903245, 6987.441004719509, 6993.650317484004, 6996.825079373057, 6300.401461861115, 6368.108464814837, 6368.554201205871, 6378.649174295459, 6415.1981002374705, 6480.254770701241, 6507.772227971998, 6547.443467305142, 6549.377809108127, 6549.639769812706], "unit": "score", "name": "mootools.html", "value": 4504.49289803953}, {"lowerIsBetter": false, "replicates": [324.4030982991296, 325.86150885873496, 333.3233535922079, 334.3013102615533, 339.21641009268575, 5714.657120572769, 5851.912221316678, 5875.647461152334, 5923.674197919113, 5928.1404196391495, 5665.688387138705, 5792.073268277077, 5815.38938411466, 5846.0, 5856.150858125569, 4454.398656181423, 4473.284274516078, 4473.351364052227, 4485.416895803549, 4496.213162696515, 4303.741775493465, 4432.091421258634, 4486.596206341429, 4498.415206023213, 4500.639948804088, 4398.494173170078, 4491.393661855656, 4501.369808226835, 4504.954950450503, 4519.774011299438, 4508.684392092522, 4513.661475389359, 4518.52555481673, 4519.050999290153, 4520.344550040242, 3975.4831871856472, 3976.363781794928, 3976.3836605325932, 3987.521497420299, 3990.700697447674, 5485.040117979377, 5571.804986825442, 5591.776328946838, 5609.943900560983, 5617.719114044281, 5238.5023422774775, 5238.81664141757, 5246.265522826808, 5254.133068043769, 5256.92114618281, 6167.537434692416, 6179.907301390483, 6189.6286222826775, 6191.783287584913, 6194.380561943814, 4155.189738001091, 4207.64235040022, 4249.553796851348, 4293.828246870153, 4392.34114882767, 6432.292447830735, 6467.159269294962, 6480.416762491398, 6482.611043337415, 6490.902636460457, 4481.148581769454, 4483.417155769795, 4487.259602165672, 4490.057088011554, 4490.079533695584, 4497.707649002804, 4504.324351347324, 4510.661700372485, 4510.797014134372, 4519.525449827786, 4975.4527002029745, 5099.158638824627, 5107.284980102789, 5109.233614957786, 5122.052420302256, 6265.8746825063245, 6273.8745225095245, 6278.15244941927, 6279.686015699197, 6280.2777680566405, 1556.7587024011295, 1571.08091766318, 1572.0567659404267, 1573.590866374728, 1573.9842601574067, 1022.6420752736632, 1025.0671888581505, 1026.1739299863682, 1037.64719995202, 1047.8009178256107, 5893.616914900518, 5901.0558310670085, 5902.557308201902, 5908.497777688945, 5914.4381283777975, 6429.935700642934, 6439.291677915426, 6448.742050318028, 6451.806445806634, 6461.741530338733, 5903.203067585907, 5907.645541267538, 5911.527077833763, 5913.290405151323, 5914.792982245601, 3378.037259381114, 3482.7736197147105, 3487.6861082502187, 3492.371373152806, 3502.0894567412656, 6624.337566243434, 6633.6019838809825, 6636.070950066995, 6638.701258443285, 6640.937450007976, 6641.800745977628, 6649.867002660017, 6653.301403352675, 6653.966730166415, 6659.0, 6566.080748695186, 6743.932560674429, 6752.189737231465, 6753.15585551806, 6755.763548275787, 6494.9025764612625, 6500.934990650033, 6504.707288172138, 6505.31694172124, 6509.1863517060365, 6146.907796382969, 6170.845728856814, 6305.90541141874, 6374.26695929974, 6375.043743438521, 6678.799636010927, 6688.699008544724, 6696.531242812956, 6698.22970358415, 6702.798916032527, 4271.402003719544, 4289.1850548395705, 4293.763842988666, 4296.785160741888, 4302.956970430256, 6309.621422714652, 6452.483801295979, 6462.159919210472, 6465.64438955862, 6477.838054048687, 6304.464120549805, 6308.369163083655, 6315.747370105144, 6316.463100636313, 6318.557700961072, 6296.275928268308, 6298.779542715983, 6305.5270854687, 6306.243250809932, 6307.337729538516, 5996.4902983245165, 6161.476274516716, 6201.751929922752, 6203.534734894811, 6294.464970477561, 6316.7157477914525, 6367.713452894538, 6369.554131210956, 6370.108184854032, 6378.170837791243, 6194.628322300677, 6205.596636218631, 6205.844853878689, 6208.068789681584, 6209.96895015522], "unit": "score", "name": "prototype.html", "value": 4702.006205295522}, {"lowerIsBetter": false, "replicates": [746.4849254014731, 803.9829615536346, 856.0669414658048, 870.2602787630515, 878.0736323179044, 13077.411516481758, 13232.27222502762, 13257.933710331446, 13261.8010729839, 13267.336633168326, 11724.941375293132, 12127.332996685178, 12571.497140114385, 12595.3072581008, 12639.494420223204, 792.8850316704074, 809.7975506123469, 810.1574362662824, 811.9512829230235, 812.7683610171102, 800.0679208721862, 810.3233799777194, 812.6180695073335, 812.7236739508566, 812.8943237379133, 854.2781349759443, 860.475110182788, 862.7756783236341, 863.1368631368631, 863.5250612163317, 849.7705619482736, 852.7868032991752, 854.8162145138825, 855.055164043729, 855.6919508976795, 630.7319389259546, 631.8894193516117, 631.936806319369, 633.5438484291303, 633.8605506788499, 12158.270503769802, 12169.452374643073, 12171.33057681827, 12193.756124877453, 12200.450979705935, 11038.227324087316, 11251.09991200702, 11665.883341166564, 12312.938435307855, 12452.937735311356, 9836.606535738561, 10161.237907156992, 10209.336393134423, 10226.897731022744, 10323.2257580681, 3502.124468882779, 3507.4914137450182, 3556.2176321209295, 3627.546556680415, 3656.6526180012856, 44360.11279774419, 45240.0, 45694.54305456936, 50382.49617503815, 50456.495435045545, 9964.701058968243, 10035.304808107767, 10152.49237538135, 10179.236557258235, 10326.277160598836, 15805.920970395075, 16996.830031699774, 17747.201375938115, 18350.541236469195, 18468.0, 7543.73596924116, 7547.0943486781935, 7557.659905304275, 7564.697412103565, 7576.696932122653, 3548.0242933193063, 3696.7412281140064, 4136.379543068504, 4189.811458484375, 4224.4930608327195, 3104.1153271318017, 3109.2537790930464, 3112.8443577821017, 3133.6082989626298, 3162.4307624627327, 574.7499189263419, 579.2296245992903, 590.976360945566, 595.5414330965219, 598.6557729305666, 509.7272958966935, 512.5104088187504, 514.8712821794552, 526.2211926349025, 591.4469970577524, 8292.37807164465, 8478.660853565912, 8771.0, 8844.646214151362, 8975.685850995184, 624.4005754475754, 667.6428110960612, 691.0360047733384, 693.2582137113241, 693.5214701855704, 3948.7433316834313, 4067.877963661095, 4135.400366946776, 4159.396887451363, 4191.119864828359, 51471.0, 51529.742351288005, 52482.0, 52507.47492525026, 52578.211326830125, 48348.27477587839, 51800.74099629553, 52031.21953170706, 52731.0, 52772.20841687378, 42524.0, 43469.17450365716, 44612.776936115115, 44717.55282447199, 45036.54963450324, 8249.83500330002, 8375.581220938806, 8390.958045209734, 8407.327413806759, 8512.914870851213, 31916.52125218077, 32923.835380822944, 33641.495377569845, 36075.639243608275, 36083.63916360803, 43879.122417552106, 43910.34134488049, 43957.56042439535, 43987.34018989782, 44095.55904440914, 10559.894401056199, 11120.666380008613, 11537.82693259585, 11842.644720658394, 12117.212381195193, 11271.267367621078, 11778.941105294418, 11934.0, 12178.634640960785, 12876.098673092794, 11197.384143872165, 11262.83105753398, 11337.773244535229, 11390.544378224778, 11608.361540115375, 11183.384913829817, 11432.94283528577, 11471.197016209118, 11551.306921584732, 12162.513499459923, 11094.722631934266, 11266.098712103176, 11481.483333249857, 11654.76690466169, 11725.941370293094, 8926.910730892867, 9010.0, 9172.908270917473, 9185.770355740893, 9281.953590232006, 8518.78703032429, 8957.910420895969, 9215.815683686154, 9385.967543570065, 9453.621855125994], "unit": "score", "name": "yui.html", "value": 6192.477607056276}], "name": "dromaeo_css", "value": 6766.05903839102}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 106.0, 111.0, 112.0, 115.0, 113.0, 112.0, 105.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 148.0, 159.0, 127.0, 153.0, 159.0, 138.0, 174.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 93.0, 102.0, 73.0, 73.0, 74.0, 114.0, 100.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 149.0, 95.0, 97.0, 95.0, 144.0, 96.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 74.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 83.0, 83.0, 82.0, 97.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 111.0, 118.0, 120.0, 119.0, 113.0, 117.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 138.0, 140.0, 142.0, 140.0, 140.0, 141.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1496.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [189.5016107636915], "unit": "score", "name": "DeltaBlue", "value": 348.90468599999986}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [2042.857142857143], "unit": "score", "name": "RayTrace", "value": 362.23237762237744}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [42645.833333333336], "unit": "score", "name": "RegExp", "value": 21.361641426477778}, {"lowerIsBetter": false, "replicates": [575.0999428897773], "unit": "score", "name": "Splay", "value": 141.69884905660373}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 18860.393947060933}]} 07:27:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18860.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1496.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6766.06"}}} 07:27:56 INFO - Return code: 0 07:27:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:27:56 INFO - # TBPL SUCCESS # 07:27:56 INFO - Running post-action listener: _resource_record_post_action 07:27:56 INFO - Running post-run listener: _resource_record_post_run 07:27:57 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540340224; Read time: 80; Write time: 356560 07:27:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236662784; Read time: 0; Write time: 194148 07:27:57 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302813184; Read time: 80; Write time: 162368 07:27:57 INFO - Running post-run listener: _upload_blobber_files 07:27:57 INFO - Blob upload gear active. 07:27:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:27: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 07:27: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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 07:27: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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 07:27:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:27:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:27:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:27:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:58 INFO - (blobuploader) - INFO - Done attempting. 07:27:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:27:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:27:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:59 INFO - (blobuploader) - INFO - Done attempting. 07:27:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:59 INFO - Return code: 0 07:27:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:27:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c148eec9e3ba0306292521b4856b1641a5af33cbd5ea2031f572ba6ce40d221ed226137f1decea1caa953b198cc77a0d30d6feb76abc4f4732f0557f0129ac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1085908c83ff1b4759ba6cf79f394a33e6e97e40a940746d0e6d06acf1b2f922167c5a8dbfa987f65d24debbe5eb053025dff3e51238cea2e05e201c4c445c"} 07:27:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:27:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:27:59 INFO - Contents: 07:27:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c148eec9e3ba0306292521b4856b1641a5af33cbd5ea2031f572ba6ce40d221ed226137f1decea1caa953b198cc77a0d30d6feb76abc4f4732f0557f0129ac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1085908c83ff1b4759ba6cf79f394a33e6e97e40a940746d0e6d06acf1b2f922167c5a8dbfa987f65d24debbe5eb053025dff3e51238cea2e05e201c4c445c"} 07:27:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:59 INFO - Copying logs to upload dir... 07:27:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:27:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.861936 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-19 07:27:57.287938) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:57.291779) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c148eec9e3ba0306292521b4856b1641a5af33cbd5ea2031f572ba6ce40d221ed226137f1decea1caa953b198cc77a0d30d6feb76abc4f4732f0557f0129ac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1085908c83ff1b4759ba6cf79f394a33e6e97e40a940746d0e6d06acf1b2f922167c5a8dbfa987f65d24debbe5eb053025dff3e51238cea2e05e201c4c445c"} build_url:https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/PjzTeLDgTmOKOYptn0lFBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c148eec9e3ba0306292521b4856b1641a5af33cbd5ea2031f572ba6ce40d221ed226137f1decea1caa953b198cc77a0d30d6feb76abc4f4732f0557f0129ac68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c1085908c83ff1b4759ba6cf79f394a33e6e97e40a940746d0e6d06acf1b2f922167c5a8dbfa987f65d24debbe5eb053025dff3e51238cea2e05e201c4c445c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:57.317125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:57.317477) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1453209152.432182-1826930008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-19 07:27:57.401467) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 07:27:57.401875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-19 07:27:57.402233) ========= ========= Total master_lag: 0.27 =========