builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1452915915.62 results: success (0) buildid: 20160115173005 builduid: ed0ccadcc2884eb3acf34a626f9eb5f5 revision: d26925accc511cc16a5aef23991de7e620fea4ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.623913) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.624401) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.624723) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.650186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.650482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.665384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.665789) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.714398) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.714722) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.715078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.715356) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 19:45:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2016-01-15 19:45:16 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094137 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.821921) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.822230) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022704 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.871384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:15.871746) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d26925accc511cc16a5aef23991de7e620fea4ae --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d26925accc511cc16a5aef23991de7e620fea4ae --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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 19:45:16,749 truncating revision to first 12 chars 2016-01-15 19:45:16,749 Setting DEBUG logging. 2016-01-15 19:45:16,749 attempt 1/10 2016-01-15 19:45:16,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d26925accc51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 19:45:17,028 unpacking tar archive at: fx-team-d26925accc51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592334 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.476979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.477328) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.003712 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.526570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.526914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.539142) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.539501) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 19:45:16.539958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 19:45:16.540257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:45:17 INFO - MultiFileLogger online at 20160115 19:45:17 in /builds/slave/test-pgo 19:45:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:45:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:45:17 INFO - {'append_to_log': False, 19:45:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:45:17 INFO - 'blob_upload_branch': 'Fx-Team', 19:45:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:45:17 INFO - 'branch': 'Fx-Team', 19:45:17 INFO - 'buildbot_json_path': 'buildprops.json', 19:45:17 INFO - 'config_files': ('talos/linux_config.py',), 19:45:17 INFO - 'default_actions': ('clobber', 19:45:17 INFO - 'read-buildbot-config', 19:45:17 INFO - 'download-and-extract', 19:45:17 INFO - 'populate-webroot', 19:45:17 INFO - 'create-virtualenv', 19:45:17 INFO - 'install', 19:45:17 INFO - 'run-tests'), 19:45:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:45:17 INFO - 'download_minidump_stackwalk': True, 19:45:17 INFO - 'download_symbols': 'ondemand', 19:45:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:45:17 INFO - 'tooltool.py': '/tools/tooltool.py', 19:45:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:45:17 INFO - '/tools/misc-python/virtualenv.py')}, 19:45:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:45:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:45:17 INFO - 'installer_path': 'installer.exe', 19:45:17 INFO - 'log_level': 'info', 19:45:17 INFO - 'log_name': 'talos', 19:45:17 INFO - 'log_to_console': True, 19:45:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:45:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:45:17 INFO - 'opt_config_files': (), 19:45:17 INFO - 'pip_index': False, 19:45:17 INFO - 'sps_profile': False, 19:45:17 INFO - 'sps_profile_interval': 0, 19:45:17 INFO - 'suite': 'dromaeojs', 19:45:17 INFO - 'system_bits': '32', 19:45:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:45:17 INFO - 'title': 'talos-linux64-ix-005', 19:45:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:45:17 INFO - 'use_talos_json': True, 19:45:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:45:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:45:17 INFO - 'work_dir': 'build'} 19:45:17 INFO - ##### 19:45:17 INFO - ##### Running clobber step. 19:45:17 INFO - ##### 19:45:17 INFO - Running pre-action listener: _resource_record_pre_action 19:45:17 INFO - Running main action method: clobber 19:45:17 INFO - rmtree: /builds/slave/test-pgo/build 19:45:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:45:17 INFO - Running post-action listener: _resource_record_post_action 19:45:17 INFO - ##### 19:45:17 INFO - ##### Running read-buildbot-config step. 19:45:17 INFO - ##### 19:45:17 INFO - Running pre-action listener: _resource_record_pre_action 19:45:17 INFO - Running main action method: read_buildbot_config 19:45:17 INFO - Using buildbot properties: 19:45:17 INFO - { 19:45:17 INFO - "project": "", 19:45:17 INFO - "product": "firefox", 19:45:17 INFO - "script_repo_revision": "production", 19:45:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:45:17 INFO - "repository": "", 19:45:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 19:45:17 INFO - "buildid": "20160115173005", 19:45:17 INFO - "pgo_build": "True", 19:45:17 INFO - "basedir": "/builds/slave/test-pgo", 19:45:17 INFO - "buildnumber": 586, 19:45:17 INFO - "slavename": "talos-linux64-ix-005", 19:45:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:45:17 INFO - "platform": "ubuntu64_hw", 19:45:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:45:17 INFO - "branch": "fx-team", 19:45:17 INFO - "repo_path": "integration/fx-team", 19:45:17 INFO - "revision": "d26925accc511cc16a5aef23991de7e620fea4ae", 19:45:17 INFO - "stage_platform": "linux64-pgo", 19:45:17 INFO - "builduid": "ed0ccadcc2884eb3acf34a626f9eb5f5", 19:45:17 INFO - "slavebuilddir": "test" 19:45:17 INFO - } 19:45:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:45:17 INFO - Running post-action listener: _resource_record_post_action 19:45:17 INFO - ##### 19:45:17 INFO - ##### Running download-and-extract step. 19:45:17 INFO - ##### 19:45:17 INFO - Running pre-action listener: _resource_record_pre_action 19:45:17 INFO - Running main action method: download_and_extract 19:45:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:17 INFO - https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/test_packages.json 19:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/test_packages.json 19:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:45:23 INFO - Downloaded 1448 bytes. 19:45:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:45:23 INFO - Using the following test package requirements: 19:45:23 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:45:23 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:45:23 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:45:23 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'jsshell-linux-x86_64.zip'], 19:45:23 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:45:23 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:45:23 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:45:23 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:45:23 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:45:23 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:45:23 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:45:23 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:45:23 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:45:23 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')]} 19:45:23 INFO - https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:45:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:45:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:45:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:30 INFO - Downloaded 22441031 bytes. 19:45:30 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'] 19:45:30 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 19:45:32 INFO - Return code: 0 19:45:32 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 19:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:32 INFO - https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:45:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:45:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:45:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:35 INFO - Downloaded 22441031 bytes. 19:45:35 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'] 19:45:35 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 19:45:36 INFO - Return code: 0 19:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:36 INFO - https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:45:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:45:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:45:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:38 INFO - Downloaded 11132144 bytes. 19:45:38 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'] 19:45:38 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 19:45:38 INFO - Return code: 0 19:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:38 INFO - https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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 19:45:41 INFO - Downloaded 55916385 bytes. 19:45:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:45:41 INFO - mkdir: /builds/slave/test-pgo/properties 19:45:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 19:45:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 19:45:41 INFO - Contents: 19:45:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:45:41 INFO - Running post-action listener: _resource_record_post_action 19:45:41 INFO - Running post-action listener: set_extra_try_arguments 19:45:41 INFO - ##### 19:45:41 INFO - ##### Running populate-webroot step. 19:45:41 INFO - ##### 19:45:41 INFO - Running pre-action listener: _resource_record_pre_action 19:45:41 INFO - Running main action method: populate_webroot 19:45:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:45:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:45:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:45:41 INFO - '--tppagecycles', 19:45:41 INFO - '7'], 19:45:41 INFO - 'tests': ['tsvgm']}}, 19:45:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:45:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:45:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:45:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:45:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'tests': ['damp', 'tps']}, 19:45:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['damp', 'tps']}, 19:45:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:45:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:45:41 INFO - 'other': {'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'other_l64': {'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'other_nol64': {'tests': ['a11yr', 19:45:41 INFO - 'ts_paint', 19:45:41 INFO - 'tpaint', 19:45:41 INFO - 'sessionrestore', 19:45:41 INFO - 'sessionrestore_no_auto_restore']}, 19:45:41 INFO - 'svgr': {'tests': ['tsvgx', 19:45:41 INFO - 'tsvgr_opacity', 19:45:41 INFO - 'tart', 19:45:41 INFO - 'tscrollx', 19:45:41 INFO - 'cart']}, 19:45:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['tsvgx', 19:45:41 INFO - 'tsvgr_opacity', 19:45:41 INFO - 'tart', 19:45:41 INFO - 'tscrollx', 19:45:41 INFO - 'cart']}, 19:45:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'tests': ['tp5o']}, 19:45:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'talos_options': ['--e10s'], 19:45:41 INFO - 'tests': ['tp5o']}, 19:45:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'talos_options': ['--xperf_path', 19:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:41 INFO - 'tests': ['tp5n']}, 19:45:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:45:41 INFO - 'talos_options': ['--e10s', 19:45:41 INFO - '--xperf_path', 19:45:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:41 INFO - 'tests': ['tp5n']}}, 19:45:41 INFO - 'talos.zip': {'path': '', 19:45:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:45:41 INFO - Running post-action listener: _resource_record_post_action 19:45:41 INFO - ##### 19:45:41 INFO - ##### Running create-virtualenv step. 19:45:41 INFO - ##### 19:45:41 INFO - Running pre-action listener: _resource_record_pre_action 19:45:41 INFO - Running main action method: create_virtualenv 19:45:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 19:45:41 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 19:45:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 19:45:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:45:41 INFO - Using real prefix '/usr' 19:45:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 19:45:42 INFO - Installing distribute.............................................................................................................................................................................................done. 19:45:44 INFO - Installing pip.................done. 19:45:44 INFO - Return code: 0 19:45:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 19:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:45:44 INFO - Using env: {'DISPLAY': ':0', 19:45:44 INFO - 'HOME': '/home/cltbld', 19:45:44 INFO - 'LANG': 'en_US.UTF-8', 19:45:44 INFO - 'LANGUAGE': 'en_US:en', 19:45:44 INFO - 'LOGNAME': 'cltbld', 19:45:44 INFO - 'MAIL': '/var/mail/cltbld', 19:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:44 INFO - 'MOZ_NO_REMOTE': '1', 19:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:44 INFO - 'NO_EM_RESTART': '1', 19:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:44 INFO - 'SHELL': '/bin/bash', 19:45:44 INFO - 'SHLVL': '1', 19:45:44 INFO - 'TERM': 'linux', 19:45:44 INFO - 'TMOUT': '86400', 19:45:44 INFO - 'USER': 'cltbld', 19:45:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:44 INFO - '_': '/tools/buildbot/bin/python'} 19:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:45:44 INFO - Cleaning up... 19:45:44 INFO - Return code: 0 19:45:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 19:45:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:45:44 INFO - Using env: {'DISPLAY': ':0', 19:45:44 INFO - 'HOME': '/home/cltbld', 19:45:44 INFO - 'LANG': 'en_US.UTF-8', 19:45:44 INFO - 'LANGUAGE': 'en_US:en', 19:45:44 INFO - 'LOGNAME': 'cltbld', 19:45:44 INFO - 'MAIL': '/var/mail/cltbld', 19:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:44 INFO - 'MOZ_NO_REMOTE': '1', 19:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:44 INFO - 'NO_EM_RESTART': '1', 19:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:44 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:44 INFO - 'SHELL': '/bin/bash', 19:45:44 INFO - 'SHLVL': '1', 19:45:44 INFO - 'TERM': 'linux', 19:45:44 INFO - 'TMOUT': '86400', 19:45:44 INFO - 'USER': 'cltbld', 19:45:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:44 INFO - '_': '/tools/buildbot/bin/python'} 19:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:44 INFO - Downloading/unpacking psutil>=0.7.1 19:45:44 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 19:45:44 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 19:45:44 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 19:45:44 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 19:45:44 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 19:45:44 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 19:45:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 19:45:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:45:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 19:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:46 INFO - Installing collected packages: psutil 19:45:46 INFO - Running setup.py install for psutil 19:45:46 INFO - building 'psutil._psutil_linux' extension 19:45:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:45:46 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 19:45:46 INFO - building 'psutil._psutil_posix' extension 19:45:46 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 19:45:46 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 19:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:46 INFO - Successfully installed psutil 19:45:46 INFO - Cleaning up... 19:45:47 INFO - Return code: 0 19:45:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 19:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 19:45:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:45:47 INFO - Using env: {'DISPLAY': ':0', 19:45:47 INFO - 'HOME': '/home/cltbld', 19:45:47 INFO - 'LANG': 'en_US.UTF-8', 19:45:47 INFO - 'LANGUAGE': 'en_US:en', 19:45:47 INFO - 'LOGNAME': 'cltbld', 19:45:47 INFO - 'MAIL': '/var/mail/cltbld', 19:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:47 INFO - 'MOZ_NO_REMOTE': '1', 19:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:47 INFO - 'NO_EM_RESTART': '1', 19:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:47 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:47 INFO - 'SHELL': '/bin/bash', 19:45:47 INFO - 'SHLVL': '1', 19:45:47 INFO - 'TERM': 'linux', 19:45:47 INFO - 'TMOUT': '86400', 19:45:47 INFO - 'USER': 'cltbld', 19:45:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:47 INFO - '_': '/tools/buildbot/bin/python'} 19:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:45:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:45:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:45:48 INFO - Installing collected packages: mozsystemmonitor 19:45:48 INFO - Running setup.py install for mozsystemmonitor 19:45:49 INFO - Successfully installed mozsystemmonitor 19:45:49 INFO - Cleaning up... 19:45:49 INFO - Return code: 0 19:45:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 19:45: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')]} 19:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45: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')]} 19:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 19:45:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:45:49 INFO - Using env: {'DISPLAY': ':0', 19:45:49 INFO - 'HOME': '/home/cltbld', 19:45:49 INFO - 'LANG': 'en_US.UTF-8', 19:45:49 INFO - 'LANGUAGE': 'en_US:en', 19:45:49 INFO - 'LOGNAME': 'cltbld', 19:45:49 INFO - 'MAIL': '/var/mail/cltbld', 19:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:49 INFO - 'MOZ_NO_REMOTE': '1', 19:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:49 INFO - 'NO_EM_RESTART': '1', 19:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:49 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:49 INFO - 'SHELL': '/bin/bash', 19:45:49 INFO - 'SHLVL': '1', 19:45:49 INFO - 'TERM': 'linux', 19:45:49 INFO - 'TMOUT': '86400', 19:45:49 INFO - 'USER': 'cltbld', 19:45:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:49 INFO - '_': '/tools/buildbot/bin/python'} 19:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:49 INFO - Downloading/unpacking blobuploader==1.2.4 19:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 19:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:51 INFO - Downloading docopt-0.6.1.tar.gz 19:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:45:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 19:45:51 INFO - Installing collected packages: blobuploader, requests, docopt 19:45:51 INFO - Running setup.py install for blobuploader 19:45:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:45:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 19:45:51 INFO - Running setup.py install for requests 19:45:52 INFO - Running setup.py install for docopt 19:45:52 INFO - Successfully installed blobuploader requests docopt 19:45:52 INFO - Cleaning up... 19:45:52 INFO - Return code: 0 19:45:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:52 INFO - Using env: {'DISPLAY': ':0', 19:45:52 INFO - 'HOME': '/home/cltbld', 19:45:52 INFO - 'LANG': 'en_US.UTF-8', 19:45:52 INFO - 'LANGUAGE': 'en_US:en', 19:45:52 INFO - 'LOGNAME': 'cltbld', 19:45:52 INFO - 'MAIL': '/var/mail/cltbld', 19:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:52 INFO - 'MOZ_NO_REMOTE': '1', 19:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:52 INFO - 'NO_EM_RESTART': '1', 19:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:52 INFO - 'SHELL': '/bin/bash', 19:45:52 INFO - 'SHLVL': '1', 19:45:52 INFO - 'TERM': 'linux', 19:45:52 INFO - 'TMOUT': '86400', 19:45:52 INFO - 'USER': 'cltbld', 19:45:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:52 INFO - '_': '/tools/buildbot/bin/python'} 19:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:52 INFO - Running setup.py (path:/tmp/pip-0arpg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:52 INFO - Running setup.py (path:/tmp/pip-55js1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:52 INFO - Running setup.py (path:/tmp/pip-Qf9nDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:52 INFO - Running setup.py (path:/tmp/pip-37Mp92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:52 INFO - Running setup.py (path:/tmp/pip-QHkxEZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:52 INFO - Running setup.py (path:/tmp/pip-5lIcQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:52 INFO - Running setup.py (path:/tmp/pip-vTOmfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:53 INFO - Running setup.py (path:/tmp/pip-_pCNMT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:53 INFO - Running setup.py (path:/tmp/pip-RMrNTH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:53 INFO - Running setup.py (path:/tmp/pip-OOX3JL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:53 INFO - Running setup.py (path:/tmp/pip-1VtBy1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:53 INFO - Running setup.py (path:/tmp/pip-zHlfOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:53 INFO - Running setup.py (path:/tmp/pip-IlVk64-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:53 INFO - Running setup.py (path:/tmp/pip-ykCCIB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:53 INFO - Running setup.py (path:/tmp/pip-LRG0gZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:53 INFO - Running setup.py (path:/tmp/pip-i6AYp2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:53 INFO - Running setup.py (path:/tmp/pip-wmVU37-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:45:53 INFO - Running setup.py install for manifestparser 19:45:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 19:45:53 INFO - Running setup.py install for mozcrash 19:45:53 INFO - Running setup.py install for mozdebug 19:45:54 INFO - Running setup.py install for mozdevice 19:45:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for mozfile 19:45:54 INFO - Running setup.py install for mozhttpd 19:45:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for mozinfo 19:45:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for mozInstall 19:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for mozleak 19:45:54 INFO - Running setup.py install for mozlog 19:45:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for moznetwork 19:45:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 19:45:54 INFO - Running setup.py install for mozprocess 19:45:54 INFO - Running setup.py install for mozprofile 19:45:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 19:45:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 19:45:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 19:45:55 INFO - Running setup.py install for mozrunner 19:45:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 19:45:55 INFO - Running setup.py install for mozscreenshot 19:45:55 INFO - Running setup.py install for moztest 19:45:55 INFO - Running setup.py install for mozversion 19:45:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 19:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:45:55 INFO - Cleaning up... 19:45:55 INFO - Return code: 0 19:45:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 19:45:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:55 INFO - Using env: {'DISPLAY': ':0', 19:45:55 INFO - 'HOME': '/home/cltbld', 19:45:55 INFO - 'LANG': 'en_US.UTF-8', 19:45:55 INFO - 'LANGUAGE': 'en_US:en', 19:45:55 INFO - 'LOGNAME': 'cltbld', 19:45:55 INFO - 'MAIL': '/var/mail/cltbld', 19:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:55 INFO - 'MOZ_NO_REMOTE': '1', 19:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:55 INFO - 'NO_EM_RESTART': '1', 19:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:55 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:55 INFO - 'SHELL': '/bin/bash', 19:45:55 INFO - 'SHLVL': '1', 19:45:55 INFO - 'TERM': 'linux', 19:45:55 INFO - 'TMOUT': '86400', 19:45:55 INFO - 'USER': 'cltbld', 19:45:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:55 INFO - '_': '/tools/buildbot/bin/python'} 19:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:55 INFO - Running setup.py (path:/tmp/pip-hnYAl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 19:45:55 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)) 19:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:55 INFO - Running setup.py (path:/tmp/pip-4m6Cv5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 19:45:55 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)) 19:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:55 INFO - Running setup.py (path:/tmp/pip-WrwbbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 19:45:55 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)) 19:45:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:56 INFO - Running setup.py (path:/tmp/pip-UmhgO9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:56 INFO - Running setup.py (path:/tmp/pip-pCCwrJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:56 INFO - Running setup.py (path:/tmp/pip-JqSSmr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:56 INFO - Running setup.py (path:/tmp/pip-EqKnZF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:56 INFO - Running setup.py (path:/tmp/pip-htre8t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:56 INFO - Running setup.py (path:/tmp/pip-HgODsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:56 INFO - Running setup.py (path:/tmp/pip-O2xgA7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:56 INFO - Running setup.py (path:/tmp/pip-yZQ8PM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 19:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:56 INFO - Running setup.py (path:/tmp/pip-X3QpfW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:56 INFO - Running setup.py (path:/tmp/pip-ecKP3Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:56 INFO - Running setup.py (path:/tmp/pip-USJvQ_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:56 INFO - Running setup.py (path:/tmp/pip-p1EebW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:56 INFO - Running setup.py (path:/tmp/pip-JVZYDN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 19:45:56 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)) 19:45:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:56 INFO - Running setup.py (path:/tmp/pip-ndOJ9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 19:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 19:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:58 INFO - Downloading blessings-1.5.1.tar.gz 19:45:58 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 19:45:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 19:45:58 INFO - Installing collected packages: blessings 19:45:58 INFO - Running setup.py install for blessings 19:45:58 INFO - Successfully installed blessings 19:45:58 INFO - Cleaning up... 19:45:59 INFO - Return code: 0 19:45:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 19:45:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:45:59 INFO - Reading from file tmpfile_stdout 19:45:59 INFO - Current package versions: 19:45:59 INFO - argparse == 1.2.1 19:45:59 INFO - blessings == 1.5.1 19:45:59 INFO - blobuploader == 1.2.4 19:45:59 INFO - docopt == 0.6.1 19:45:59 INFO - manifestparser == 1.1 19:45:59 INFO - mozInstall == 1.12 19:45:59 INFO - mozcrash == 0.16 19:45:59 INFO - mozdebug == 0.1 19:45:59 INFO - mozdevice == 0.48 19:45:59 INFO - mozfile == 1.2 19:45:59 INFO - mozhttpd == 0.7 19:45:59 INFO - mozinfo == 0.9 19:45:59 INFO - mozleak == 0.1 19:45:59 INFO - mozlog == 3.1 19:45:59 INFO - moznetwork == 0.27 19:45:59 INFO - mozprocess == 0.22 19:45:59 INFO - mozprofile == 0.28 19:45:59 INFO - mozrunner == 6.11 19:45:59 INFO - mozscreenshot == 0.1 19:45:59 INFO - mozsystemmonitor == 0.0 19:45:59 INFO - moztest == 0.7 19:45:59 INFO - mozversion == 1.4 19:45:59 INFO - psutil == 3.1.1 19:45:59 INFO - requests == 1.2.3 19:45:59 INFO - wsgiref == 0.1.2 19:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 19:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 19:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:45:59 INFO - Using env: {'DISPLAY': ':0', 19:45:59 INFO - 'HOME': '/home/cltbld', 19:45:59 INFO - 'LANG': 'en_US.UTF-8', 19:45:59 INFO - 'LANGUAGE': 'en_US:en', 19:45:59 INFO - 'LOGNAME': 'cltbld', 19:45:59 INFO - 'MAIL': '/var/mail/cltbld', 19:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:59 INFO - 'MOZ_NO_REMOTE': '1', 19:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:59 INFO - 'NO_EM_RESTART': '1', 19:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:59 INFO - 'SHELL': '/bin/bash', 19:45:59 INFO - 'SHLVL': '1', 19:45:59 INFO - 'TERM': 'linux', 19:45:59 INFO - 'TMOUT': '86400', 19:45:59 INFO - 'USER': 'cltbld', 19:45:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:59 INFO - '_': '/tools/buildbot/bin/python'} 19:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 19:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 19:45:59 INFO - Cleaning up... 19:45:59 INFO - Return code: 0 19:45:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 19:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 19:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:45:59 INFO - Using env: {'DISPLAY': ':0', 19:45:59 INFO - 'HOME': '/home/cltbld', 19:45:59 INFO - 'LANG': 'en_US.UTF-8', 19:45:59 INFO - 'LANGUAGE': 'en_US:en', 19:45:59 INFO - 'LOGNAME': 'cltbld', 19:45:59 INFO - 'MAIL': '/var/mail/cltbld', 19:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:59 INFO - 'MOZ_NO_REMOTE': '1', 19:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:59 INFO - 'NO_EM_RESTART': '1', 19:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 19:45:59 INFO - 'SHELL': '/bin/bash', 19:45:59 INFO - 'SHLVL': '1', 19:45:59 INFO - 'TERM': 'linux', 19:45:59 INFO - 'TMOUT': '86400', 19:45:59 INFO - 'USER': 'cltbld', 19:45:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:59 INFO - '_': '/tools/buildbot/bin/python'} 19:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:59 INFO - Downloading/unpacking jsonschema 19:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:46:01 INFO - Downloading/unpacking functools32 (from jsonschema) 19:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:01 INFO - Downloading functools32-3.2.3-2.tar.gz 19:46:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:46:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 19:46:01 INFO - warning: no files found matching '*.txt' 19:46:01 INFO - no previously-included directories found matching 'build' 19:46:01 INFO - no previously-included directories found matching 'dist' 19:46:01 INFO - no previously-included directories found matching '.git*' 19:46:01 INFO - Installing collected packages: jsonschema, functools32 19:46:01 INFO - Running setup.py install for functools32 19:46:01 INFO - warning: no files found matching '*.txt' 19:46:01 INFO - no previously-included directories found matching 'build' 19:46:01 INFO - no previously-included directories found matching 'dist' 19:46:01 INFO - no previously-included directories found matching '.git*' 19:46:01 INFO - Successfully installed jsonschema functools32 19:46:01 INFO - Cleaning up... 19:46:01 INFO - Return code: 0 19:46:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 19:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99449f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2031630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, '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': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', '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 19:46:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 19:46:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:46:01 INFO - Using env: {'DISPLAY': ':0', 19:46:01 INFO - 'HOME': '/home/cltbld', 19:46:01 INFO - 'LANG': 'en_US.UTF-8', 19:46:01 INFO - 'LANGUAGE': 'en_US:en', 19:46:01 INFO - 'LOGNAME': 'cltbld', 19:46:01 INFO - 'MAIL': '/var/mail/cltbld', 19:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:01 INFO - 'MOZ_NO_REMOTE': '1', 19:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:01 INFO - 'NO_EM_RESTART': '1', 19:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:01 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:01 INFO - 'SHELL': '/bin/bash', 19:46:01 INFO - 'SHLVL': '1', 19:46:01 INFO - 'TERM': 'linux', 19:46:01 INFO - 'TMOUT': '86400', 19:46:01 INFO - 'USER': 'cltbld', 19:46:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:01 INFO - '_': '/tools/buildbot/bin/python'} 19:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:02 INFO - Downloading/unpacking flake8 19:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:46:03 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 19:46:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:46:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:46:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:46:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 19:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:46:04 INFO - no previously-included directories found matching 'docs/_build' 19:46:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:46:04 INFO - Running setup.py install for pep8 19:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:46:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:46:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:46:04 INFO - no previously-included directories found matching 'docs/_build' 19:46:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 19:46:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:46:04 INFO - Cleaning up... 19:46:04 INFO - Return code: 0 19:46:04 INFO - Running post-action listener: _resource_record_post_action 19:46:04 INFO - Running post-action listener: _start_resource_monitoring 19:46:04 INFO - Starting resource monitoring. 19:46:04 INFO - ##### 19:46:04 INFO - ##### Running install step. 19:46:04 INFO - ##### 19:46:04 INFO - Running pre-action listener: _resource_record_pre_action 19:46:04 INFO - Running main action method: install 19:46:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 19:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 19:46:04 INFO - Reading from file tmpfile_stdout 19:46:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:46:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 19:46:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 19:46:05 INFO - Reading from file tmpfile_stdout 19:46:05 INFO - Output received: 19:46:05 INFO - Usage: mozinstall [options] installer 19:46:05 INFO - Options: 19:46:05 INFO - -h, --help show this help message and exit 19:46:05 INFO - -d DEST, --destination=DEST 19:46:05 INFO - Directory to install application into. [default: 19:46:05 INFO - "/builds/slave/test-pgo"] 19:46:05 INFO - --app=APP Application being installed. [default: firefox] 19:46:05 INFO - mkdir: /builds/slave/test-pgo/build/application 19:46:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 19:46:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 19:46:21 INFO - Reading from file tmpfile_stdout 19:46:21 INFO - Output received: 19:46:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 19:46:21 INFO - Running post-action listener: _resource_record_post_action 19:46:21 INFO - ##### 19:46:21 INFO - ##### Running run-tests step. 19:46:21 INFO - ##### 19:46:21 INFO - Running pre-action listener: _resource_record_pre_action 19:46:21 INFO - Running main action method: run_tests 19:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 19:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 19:46:21 INFO - Python 2.7.3 19:46:21 INFO - Return code: 0 19:46:21 INFO - grabbing minidump binary from tooltool 19:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:21 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20c2840>, '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 0x202f6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202fb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 19:46:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 19:46:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:46:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:46:21 INFO - Return code: 0 19:46:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 19:46:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 19:46:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 19:46:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 19:46:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 19:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 19:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 19:46:22 INFO - Return code: 0 19:46:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:46:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 19:46:22 INFO - Using env: {'DISPLAY': ':0', 19:46:22 INFO - 'HOME': '/home/cltbld', 19:46:22 INFO - 'LANG': 'en_US.UTF-8', 19:46:22 INFO - 'LANGUAGE': 'en_US:en', 19:46:22 INFO - 'LOGNAME': 'cltbld', 19:46:22 INFO - 'MAIL': '/var/mail/cltbld', 19:46:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:46:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 19:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:22 INFO - 'MOZ_NO_REMOTE': '1', 19:46:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 19:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:22 INFO - 'NO_EM_RESTART': '1', 19:46:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 19:46:22 INFO - 'PWD': '/builds/slave/test-pgo', 19:46:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 19:46:22 INFO - 'SHELL': '/bin/bash', 19:46:22 INFO - 'SHLVL': '1', 19:46:22 INFO - 'TERM': 'linux', 19:46:22 INFO - 'TMOUT': '86400', 19:46:22 INFO - 'USER': 'cltbld', 19:46:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914', 19:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:22 INFO - '_': '/tools/buildbot/bin/python'} 19:46:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 19:46:22 INFO - mozversion application_buildid: 20160115173005 19:46:22 INFO - mozversion application_changeset: d26925accc511cc16a5aef23991de7e620fea4ae 19:46:22 INFO - mozversion application_display_name: Nightly 19:46:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:46:22 INFO - mozversion application_name: Firefox 19:46:22 INFO - mozversion application_remotingname: firefox 19:46:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:46:22 INFO - mozversion application_vendor: Mozilla 19:46:22 INFO - mozversion application_version: 46.0a1 19:46:22 INFO - mozversion platform_buildid: 20160115173005 19:46:22 INFO - mozversion platform_changeset: d26925accc511cc16a5aef23991de7e620fea4ae 19:46:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:46:22 INFO - mozversion platform_version: 46.0a1 19:46:22 INFO - using testdate: 1452915982 19:46:22 INFO - actual date: 1452915982 19:46:22 INFO - starting webserver on 'localhost:55990' 19:46:22 INFO - SUITE-START | Running 3 tests 19:46:22 INFO - TEST-START | dromaeo_css 19:46:22 INFO - operating with platform_type : linux_ 19:46:22 INFO - Initialising browser for dromaeo_css test... 19:46:22 INFO - TEST-INFO | started process 28040 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjdlOfC/profile http://localhost:55990/getInfo.html) 19:46:26 INFO - PROCESS | 28040 | __metrics Screen width/height:1600/1200 19:46:26 INFO - PROCESS | 28040 | colorDepth:24 19:46:26 INFO - PROCESS | 28040 | Browser inner width/height: 1024/697 19:46:26 INFO - PROCESS | 28040 | __metrics 19:46:26 INFO - PROCESS | 28040 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:46:26 INFO - PROCESS | 28040 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:46:27 INFO - TEST-INFO | 28040: exit 0 19:46:27 INFO - Browser initialized. 19:46:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:46:27 INFO - TEST-INFO | started process 28132 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjdlOfC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:39 INFO - PROCESS | 28132 | RSS: Main: 149192704 19:46:39 INFO - PROCESS | 28132 | 19:47:30 INFO - PROCESS | 28132 | 1452916050423 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] 19:49:38 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55990/tests/dromaeo/cssquery-ext.html) 19:49:39 INFO - PROCESS | 28132 | RSS: Main: 233754624 19:49:39 INFO - PROCESS | 28132 | 19:52:41 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-ext.html (next: http://localhost:55990/tests/dromaeo/cssquery-jquery.html) 19:52:42 INFO - PROCESS | 28132 | RSS: Main: 230666240 19:52:42 INFO - PROCESS | 28132 | 19:55:44 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55990/tests/dromaeo/cssquery-mootools.html) 19:55:45 INFO - PROCESS | 28132 | RSS: Main: 222732288 19:55:45 INFO - PROCESS | 28132 | 19:58:47 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55990/tests/dromaeo/cssquery-prototype.html) 19:58:47 INFO - PROCESS | 28132 | RSS: Main: 204050432 19:58:47 INFO - PROCESS | 28132 | 20:01:50 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55990/tests/dromaeo/cssquery-yui.html) 20:01:50 INFO - PROCESS | 28132 | RSS: Main: 208109568 20:01:50 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-yui.html (next: http://localhost:55990/tests/dromaeo/cssquery-dojo.html) 20:04:53 INFO - PROCESS | 28132 | RSS: Main: 259719168 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | __start_tp_report 20:04:53 INFO - PROCESS | 28132 | _x_x_mozilla_page_load 20:04:53 INFO - PROCESS | 28132 | _x_x_mozilla_page_load_details 20:04:53 INFO - PROCESS | 28132 | |i|pagename|runs| 20:04:53 INFO - PROCESS | 28132 | |0;dojo.html;3088.4286407014706;3111.2377467520455;3158.873645054198;3171.7462602991764;3174.1905814017423;4949.307097006413;4951.851444456667;4955.727434991083;4996.075725990694;5010.423801262856;5058.11482990477;5064.974675126628;5089.3638295213095;5130.256112863642;5151.021305951876;4596.287575425806;4603.917420848332;4618.584327410533;4656.8602941911795;4719.174144524694;4703.482616912137;4713.717176969376;4741.8103275868925;4759.357486739298;4759.524047595248;4542.205114105035;4578.45058592971;4629.513901040393;4638.79125439356;4644.024754801496;4587.931181032287;4611.146937816515;4611.44662640482;4619.8152073917;4655.3947986761505;4586.954130458686;4594.1271158479785;4596.448426188846;4606.838760643362;4638.397008388922;4753;4814.590759785422;4850.442199147108;4871.926921096187;4873.707577545359;5233.188855727369;5236.21456781482;5240.187770895517;5242;5262.289590905217;5275.28783614211;5276.12943864262;5291.391489978625;5303.814366497154;5358.866028349323;5089.982003599295;5090.083784918713;5092.490750924915;5132.512411320956;5137.255098010767;5464.836054918359;5493.093639549509;5508.944910550843;5514.531264842453;5522.502974732293;5155.639105262596;5255.605829562798;5320.907262480851;5330.227117068003;5369.704666243316;5402.91895621566;5497.587680923947;5498.120300751861;5503.11950087984;5538.16927460876;5362.570994320523;5369.221462887859;5372.328458942632;5377.274068000848;5432.348118225759;5258.8159414420315;5340.626156169031;5354.598405119632;5383.919241211385;5398.730063496888;4263.829446822155;4268.338407546773;4273;4286.61420472159;4309.806058727365;3805.219929914361;3812.4662547243406;3820.751651142667;3843.9231215375535;3852.1332700142243;4984.700917944862;4996.675216110941;5047.318611987408;5052.292679024939;5057.266696329012;5428.022955867982;5435.239066530688;5453.890922181614;5455.263539422127;5481.150421684645;5067.315912351859;5075.771590278372;5077.796888124433;5079.97460012705;5124.538791508782;4589.931151032737;4608.700434471749;4666.160091183619;4670.276107203389;4705.082508910729;5557.472040156179;5560.193771903132;5573.804916827973;5577.972110139423;5588.804391846266;5388.137897936312;5395.46045395473;5397.136458166675;5397.730113494231;5444.373897001737;5460.5085542301385;5471.316085489314;5489.862753431196;5541.251930989426;5555.138953462219;5357.678539287655;5365.490278423544;5376.435474275301;5379.811706590407;5379.919301210563;5343.3587969443915;5427.538659214011;5429.40276569585;5444.292242008513;5504.201890725903;5229.21561765723;5298.284731561344;5321.707306098202;5333.626646134733;5375.623706340675;5292.9206061908335;5293.920591191212;5299.231611416246;5302.893942121059;5357.785688572413;5098.515641014098;5180.067587834226;5222.921656175236;5225.346831646044;5230.084735171406;5317.680939143664;5321.760520776652;5348.679079255257;5394.163904594794;5398.40617532079;5166.535011848951;5172.844814655567;5182.274481572658;5185.066687996197;5192.766325515286 20:04:53 INFO - PROCESS | 28132 | |1;ext.html;515.5128403658545;530.6921985248556;561.9747111379986;579.1052823387867;603.9491285163814;28708.712912870866;29380.853095734517;36677.26645467093;36913;37035.81482092592;39365;39749.60250397495;39822.8008859956;39911.40132898001;40201.798991005075;7330.523515971445;8341.124181960882;8520.701775437861;8538.103499132563;8543.530105844176;7362.5582465052;7487.962560187191;9839.852402213972;10074.546645400938;10133.594656213743;9964.90035099647;9966.103050725433;10055.69832905014;10063.496825158749;10072.546735396889;9798.118169364756;9879.209663226924;9888.752781180456;9890.20878329732;9892.50537473127;9760.4631745254;9869.60521579136;9921.10710036093;9928.305018648698;9931.056549627774;39890.80054599737;40135.7993210035;40148.197036059406;40249.396259056135;40275.59724402748;3127.18693139783;3298.3897978873983;3308.1894935740656;3374.173327534745;3442.1394651337164;29796.553051704243;29924.102276931728;30166;30260.394792104034;30880;3957.70618236099;4071.8982025449304;4081.7346872453195;4092.6112019358116;4118.670506359484;224450;225423;225909.87045064833;226171;226852;53390.262681611915;55087.44912550903;56954.43045569574;57407.13889291664;61351.38648613546;55015;55567.722161388934;55703.164452533245;55922.44077559172;55941.440585594435;15119.773203401957;15364.539063828102;15383.692326153414;15383.846161538466;15384.692306153815;11392.20254582188;11411.828822567668;11449;11451.59919402817;11453.770924581628;19312.42062738092;20234.494137646383;20286.59426811485;20307.492312692302;20343.898280508798;7690.346320562703;7756.121939030485;7922.247386498273;7923.524588524707;7942.404319676048;955.6894009446958;1024.4826362686945;1079.7570546627103;1112.8330750387345;1116.7040734205443;28366.71633283682;28509.71490285112;28884.27789305284;28988.855055724587;29115.41769164605;1014.8629934958686;1043.473046111724;1045.5086109528509;1055.762453447968;1103.8068338040812;14798.704025919636;15142.848571514363;15356.692866142837;15423.922880385526;16115;392690;398189;399393;400491;401258;54342.72828635832;54405.727971360684;54861.725691371284;54874.72562637161;54909;1275.661949583361;1304.4346783859407;1320.069351107467;1323.1135139456587;1337.699017721005;29277;30291.69708302889;30473;31283.84358078195;33317.33365332728;42832.5716742841;44633.33050004188;48132.7593362031;48165;49180;303037;304490;306850;307511.4624426864;307829;40399.39400909047;40612;41357.79321103375;41596.37605435981;41620.37569436521;44433.77783111064;44551.33173002472;44606.776966114965;44963;45807;36883.44674829826;36975.63024369722;37552.624473756005;38112.809435952644;38456;37847.2430551393;38498.2300353997;38605.42091868568;38736;38767;35756.28487430185;35789.46315805213;36175;38296.2340753189;39563.20873582455;30227;32799.964098548684;33262.833685831414;33510.32979340448;33755;24996;25053.624195636716;25271.87364063168;25325;25754.227373178834 20:04:53 INFO - PROCESS | 28132 | |2;jquery.html;362.24110488526526;366.541822721598;366.5912507554078;366.68465119996796;371.4187296880382;13350.265735384573;13634.522791702293;15179.089254644716;15903.602409939756;16789.580260493494;14550;15318.387264509407;15554.200243956084;15671.686566268669;16440.83559164408;5264.131418315983;5470.9452905471035;5478.041342765;5481.561475081984;5486.643368181076;3771.377722675755;3854.4411060396224;5375.516203541681;5464.26232458617;5737;5756.942430575704;5818.447247511501;5895.764169433218;5897.852553686149;5898.7640494380175;5746.942530574704;5839.474447299764;5904.7047647617665;5908.14331921869;5912.615679980809;4724.929126063112;4923.926141107886;4926;5184.015037142931;5211.661242019294;11748.588799392066;11974.34141122238;13313.40089695966;18739.437816865517;18820.117988201207;1947.5325921778813;2056.0542150610736;2064.9277275295444;2095.224766836265;2130.3502431758307;8359.665613375457;8361.95819020907;8835.514046727427;9030.322725795526;9043.050479699668;1744.4592176425222;1838.5679365349133;1851.3982955539368;1870.4669169286824;1886.9339573115012;54707.45292547103;54820.45179548193;55241.44758552443;56081.71959140219;56141.71929140369;9463.858042129374;9842.65550705722;10180.134688551409;10220.897791021995;10315.27793054479;13248.867511324956;13312.467501300032;13371.665708357368;13398.933005334911;13420.731585368238;7226.421886249087;7291.52605080668;7293.9635301823155;7325.743598974117;7334.743283985142;6983.057287266256;7086.787396378117;7151.821204469826;7242.311980361857;7244.565326080452;4384.6711496637245;4414.168120230132;4415.448068991376;4457.2645513489915;4497.190505709003;1698.558374822555;1705.8123606403285;1727.956801079983;1764.109124891947;1775.8756887017785;890.1276748786225;920.332758749901;933.281373342536;941.2846236860036;953.2421724728857;13365.732685346238;15225.771613425808;15330.770038449433;15468;15801.604959876095;861.4751889156158;909.0909090909091;910.1217325281135;924.5654542365078;992.8113658405024;9234.676786312446;9870.950645246729;9932.652357167464;9943.30396872212;10187.683606238492;366255;371599;558391;560707;566757;69318.65340673365;72065.6396718013;72386.27613723901;72484.55030899352;73128;1108.3239224073309;1130.949107290174;1135.8977692007593;1143.1426430177366;1149.0462915779883;14685.339159737623;15024.399024039354;15095.698086037997;15190.468333608713;15406.768898466307;31542.842285788425;32203.62635938663;33968.66031339655;35362.292754144255;35785.46321805227;42040.1591968165;42650.360244596974;42733.145337092465;43686.344704828814;44417.33373999328;6863.622500762506;7051.365377116084;7311.634418278958;7361.374283185775;7370.041894553674;9547.65081221008;10530.736731581772;10772.730681733019;10798.812130665778;11246.887531124585;8764.824703505767;9263.953680231556;9325.673601423918;9479.668211612561;9702.563384647567;8686.695965641173;9548.949615542424;9552.617895284111;10016.749581260527;10237.641682541373;9452.196563292197;10009.349392289478;10147.036031576989;10147.949260253947;10467.371957682564;7170.462215333767;7245.5652660840515;7283.053203083565;7292.927070729224;7385.7045718170675;7528.736494222676;9432.245420366491;9546.665866694633;9630;10147.137493312855 20:04:53 INFO - PROCESS | 28132 | |3;mootools.html;1317.4137508808572;1410.858914108589;1414.9221792801395;1551.7517197248442;1734.080937103335;6769.593824370535;7261.927380726192;7419.109706835187;7421.9628901855485;7438.218987006368;7261.636918154098;7411.629418529079;7416.888746668791;7437.144728356241;7469.551826890377;1944.7957964413745;1989.094961792381;2222.211115054157;2258.7402448718362;2270.14869423966;2278.5784629843533;2288.9084436622516;2291.0377641390573;2291.633338665814;2294.9655755163685;2197.571473562656;2273.7044184256106;2276.931692049233;2278.5215104828007;2280;2214.2432671324145;2222.3444083995178;2297.2074634251157;2311.6879221305076;2317.8725170115636;2252.583272094668;2258.232201051634;2259.1302348595746;2263.6378179491203;2313.8611683299055;7561.546307221584;7675.270849269311;7676.193999630014;7676.884846727304;7692.423068269902;4482.618977386894;4558.521355257716;4567.703099298535;4570.063137056895;4571.085782843445;3001.8799248030055;3070.186400603842;3105.9844700776353;3111.1910903165112;3167.572377729;1006.0392325329293;1033.6588925654517;1047.8899715529913;1056.3503445381111;1104.536094840161;9867.457289849055;9916.801663966753;9926.404415735078;9940.701778946643;9942.751431214205;3932.8623498177426;4068.4507591475362;4106.815193316308;4110.321796903538;4114.19773144234;8303.00363956329;8340.29107525855;8346.332293416634;8381.58092095405;8414.747557573282;4613.792379342937;4622.399088118523;4624.028953919715;4631.560001799824;4635;4235.131797981407;4277.230098582285;4286.678499112579;4288.828446862153;4289.463817022872;3209.1335339458215;3241.3517296540313;3306.04124803809;3481.5125882376487;3603.063203567039;1034.849946757716;1099;1099.8680158381046;1103.222228329042;1110.3227031510771;1292.6832925933206;1302.3553341096217;1314.8487923888683;1334.3395019465427;1340;6804.591724496447;6985.301469852974;6990.09128813251;7043.154821421463;7046.788596342118;1086.9945650271857;1113.549012649878;1120.3389999900098;1130.0733398613058;1136.2727854173336;5724.25584673998;5821.79623713168;5831.154482599999;5847.970760146172;5863.5309175265875;8706.825863482694;8931.598078086501;8946.239569636524;8959.865602015974;9038.367314288069;8952.373333866566;9103.408278461879;9104.908950910538;9110.772230694285;9123.270138388913;6952.5480843745;7294.781156565312;7325.340719335285;7398;7402.629868506553;7237.855242895007;7292;7359.852802944019;7383.741569045058;7387.889181662172;8191;8238.50568965864;8381.748547543584;8446.239838414573;8453.535055571756;8455.915440845758;8533.061363249913;8658.826823463369;8697.173768491983;8712.78218044554;6817.079694241214;6901.447884169354;6917.688704008432;6937.375636192565;6968.303169682991;6424.646644434601;6574.8356291091195;6595.373439523238;6739.629320387426;6741.393274605309;6454.677266136769;6501.8699626008165;6635.336466353519;6649.60102393858;6673.9332606673315;6522.34776522344;6565.835854103686;6669.799906002828;6691.230508491391;6775.220849602359;6726.8990965136545;6778.93221067783;6795.830104247236;6800.149981252343;6804.795856124324;6031.577789554689;6164.660943648142;6200.410960958701;6205.131281620486;6206.193194884636;6369.617822930639;6409.102725618324;6430.839229019312;6448.967755161194;6451.709673064817 20:04:53 INFO - PROCESS | 28132 | |4;prototype.html;337.5072394304316;340.71209827695594;341.2152050284345;345.5576861617129;349.0279571393669;5863.2964044314685;5927.851803704904;5935.109733539965;5963.254593175853;5997.100434934762;5646.971765141168;5731.197632331477;5836.066229403296;5886.882262354761;5912.556558258127;4583.724976501404;4602.562756538124;4606.907861842761;4610.723356598598;4614.123316569858;4373;4608.654350923677;4609.907801843978;4611.492735799059;4613.054323863616;4409.581089796464;4451.5993560579545;4515.7516336601475;4518.728876267434;4531;4503.369528266046;4512.706674066175;4515.390422292981;4524.502304746492;4528.139653465831;4005.619466150711;4007.9779656187775;4009.69927255457;4017.31705610047;4023.0344717267644;5464.3442786865835;5594.636348637367;5604.299462567179;5607.439256074401;5625.38120806711;5296.894062118775;5316.043112239795;5319.7340132993195;5322.866928326784;5336.599755018389;6230.501559875199;6241.843953901143;6246.469050130744;6250.531210159256;6255.562110652256;4412.977935110336;4415.271480205763;4423.955760442386;4429.357743127261;4444.599986001275;6343.682815859234;6406.071119687619;6537.738490460376;6571.2771595124495;6584.144061272004;4624.722516649012;4625.190591646448;4625.791839367236;4628.190066738307;4635.721856688542;4672.859814205579;4677.859664210079;4685.226937555333;4687.718736875799;4696.8121275148615;5324.068288049576;5337.172738225504;5342.171963345688;5342.813001544927;5346.358436987509;6085.5435842312;6280.183576135073;6315.747370105236;6324.747010119636;6333.968330158412;1622.4564770801678;1657.9751303730454;1658.1211957662458;1658.6599747051825;1658.7760652312024;1091.0671375973586;1101.6254473479055;1109.9056580190613;1136.6760473265244;1141.2981016674685;5951;5957.523398128139;5960.7019649017375;5962.284525856925;5971.164037034819;6486.254080780676;6486.902696459462;6487.967560162169;6491.383318584727;6497.480201583862;5748.281464816898;5790.826275211751;5820.039693450533;5844.707764611752;5850.063989761617;3436.810975396377;3515.2442224921765;3519.788812671248;3521.2253304273017;3525.11872031992;6797.150356205474;6800.795976120724;6802;6807.047013418125;6810.557313774589;6536.758015977044;6671.532992690465;6683.899741503881;6683.966580167068;6686.030525573765;6784.491163162783;6786.694598743068;6798.388145066869;6799.3200679931615;6803.387695107464;6523.706433210422;6526.641034742945;6537.215534135934;6543.901841472287;6546.279909209888;6316.968415157895;6445.774397896239;6453.225612926479;6459.095726598374;6465.903011454926;6782.728690852508;6785.423239024738;6785.7624983127325;6790.25307216196;6794.388505034571;4619.099275641218;4619.538046195354;4623.791929363119;4624.722516649012;4628.889066624053;6284.654344011124;6500.804975850732;6520.413162815369;6532.640704761284;6556.114924485133;6374.96812515953;6383.787080454698;6391.712372943136;6395.136656551492;6400.167978162809;6360.109584658059;6371.74513019474;6431.035344698333;6436.195475565554;6441.194850643669;6119.571629985859;6214.316425193135;6222.408871157233;6249.312575616587;6251.843703907439;6361.395667411589;6373.968130159319;6379.553431259953;6386.87226255463;6387.297397286202;6226.1905952227735;6228.813135605939;6232.937670623417;6236.438720515175;6238.376162383907 20:04:53 INFO - PROCESS | 28132 | |5;yui.html;656.5338609587193;703.0789665538146;711.3739908880185;801.3749275565061;852.6504133305347;12394.070444716648;12494.56269030583;12498.125131240817;12552.246865188095;12570.68573285666;11079.335239885593;11276.830847537294;11284.435778211076;11287.49206285717;11321.150913681466;636.5162476517834;764.2014095270456;778.3228591125728;784.9921500785005;786.9173736757643;778.8636988526985;783.600363814453;785.4619585583865;785.6150486261719;785.7839094249099;667.9532432729711;820.7742870710573;824.9628766705513;825.6408462318881;826.1614461321764;667.933206679333;668.4318329419979;669.8727241824038;801.2748462641318;819.1276290750392;604.5224272824463;604.6100265328838;605.4248463959257;605.8121982185537;605.8879107365152;12483.31341776202;12512.499500019989;12523.74952500954;12524.624261272176;12533.561325353568;11410.54357825686;12162.270263784201;12398.938005310007;12594.81107783384;12656.344399562558;10494.737631559196;10552.736181595445;10563.47182640865;10700.839487407695;10746.194035447295;3552.8934131976084;3585.569731632195;3607;3614.331348700499;3755.7370984031127;47230;47245.29132063022;47287.76356118232;47421.28868066947;47490.28764568534;9920.553575089138;10018.248631352677;10213.540390682288;10289.74275643115;10466.63366782159;18452.815471845377;18528;18596.25614975413;18620.255189792526;18627.06864656762;7171.1394632644415;7214.96392518034;7328.047353843966;7411.629418529052;7449.702011919571;4253.128108737701;4309.698321117492;4335.848245311399;4345.065810850619;4412.205802955499;2963.703629637019;3006.5490176473268;3009.0972708187455;3009.653889802657;3010.036788227746;518.4530320511897;530.6259087343491;536.1983834167944;546.4835730234889;550.3340957441541;535.0129011972904;572.9341125770507;630.7508534128993;635.4725577770439;653.3629711031801;8049.315808156372;8096.757097287091;8134.3085837703275;8353.913991181107;8363.456375335583;675.3078094952713;682.5597489619167;684.7482484912814;687.8624275144991;691.4433880725963;3974.761514309093;4002.6397624213378;4092.897677558085;4207.389928460356;4217.304144816132;59744.40255597475;60686.69656651688;60787;60933.695331523944;60940.39059609436;51526.74236628868;52521.47478525242;52667.47332526703;52724.73637631787;52736.20895686568;47156.7642161787;47821.76089119532;47919.520804792206;48261.75869120702;48303.516964829905;8113.5131892086665;8120.918790812252;8233.135520770233;8327.125651806473;8334.583270836556;35580.28839423145;35881.282374352886;36384.818075909454;36396.454053188696;36429.45355819612;41858.79070604749;47029.05941881212;47220.52779472162;47563;47742.761286193345;10076.294659373774;11091.279066860629;11108.500117494894;11216.439178041228;11564.595239166589;12412.255264684149;12852.421641026363;12854.293013883953;13115.213087214797;13168.868311316764;11871.347075910562;12249.571265005681;12534.561290354794;12618.936905315415;12627.810582841448;11545.942270288595;11869.228500147463;11894.286342819458;12036.699082523008;12277.263364198177;11414.48634811419;11735.882641173821;11769.823452648388;11903.464344104363;12180.512779489076;9526.904730952601;9624.470654114091;9708.75728106803;9921.751956201153;9946.104850563484;8696.91303086961;8706.825863482822;8903.421277616933;9444.622215111593;10057 20:04:53 INFO - PROCESS | 28132 | __end_tp_report 20:04:53 INFO - PROCESS | 28132 | __start_cc_report 20:04:53 INFO - PROCESS | 28132 | _x_x_mozilla_cycle_collect,687 20:04:53 INFO - PROCESS | 28132 | __end_cc_report 20:04:53 INFO - PROCESS | 28132 | __startTimestamp1452917093494__endTimestamp 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | ------- Summary: start ------- 20:04:53 INFO - PROCESS | 28132 | Number of tests: 6 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#0] dojo.html Cycles:165 Average:5025.88 Median:5192.77 stddev:519.53 (10.0%) stddev-sans-first:498.40 20:04:53 INFO - PROCESS | 28132 | Values: 3088.4 3111.2 3158.9 3171.7 3174.2 4949.3 4951.9 4955.7 4996.1 5010.4 5058.1 5065.0 5089.4 5130.3 5151.0 4596.3 4603.9 4618.6 4656.9 4719.2 4703.5 4713.7 4741.8 4759.4 4759.5 4542.2 4578.5 4629.5 4638.8 4644.0 4587.9 4611.1 4611.4 4619.8 4655.4 4587.0 4594.1 4596.4 4606.8 4638.4 4753.0 4814.6 4850.4 4871.9 4873.7 5233.2 5236.2 5240.2 5242.0 5262.3 5275.3 5276.1 5291.4 5303.8 5358.9 5090.0 5090.1 5092.5 5132.5 5137.3 5464.8 5493.1 5508.9 5514.5 5522.5 5155.6 5255.6 5320.9 5330.2 5369.7 5402.9 5497.6 5498.1 5503.1 5538.2 5362.6 5369.2 5372.3 5377.3 5432.3 5258.8 5340.6 5354.6 5383.9 5398.7 4263.8 4268.3 4273.0 4286.6 4309.8 3805.2 3812.5 3820.8 3843.9 3852.1 4984.7 4996.7 5047.3 5052.3 5057.3 5428.0 5435.2 5453.9 5455.3 5481.2 5067.3 5075.8 5077.8 5080.0 5124.5 4589.9 4608.7 4666.2 4670.3 4705.1 5557.5 5560.2 5573.8 5578.0 5588.8 5388.1 5395.5 5397.1 5397.7 5444.4 5460.5 5471.3 5489.9 5541.3 5555.1 5357.7 5365.5 5376.4 5379.8 5379.9 5343.4 5427.5 5429.4 5444.3 5504.2 5229.2 5298.3 5321.7 5333.6 5375.6 5292.9 5293.9 5299.2 5302.9 5357.8 5098.5 5180.1 5222.9 5225.3 5230.1 5317.7 5321.8 5348.7 5394.2 5398.4 5166.5 5172.8 5182.3 5185.1 5192.8 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#1] ext.html Cycles:180 Average:48140.70 Median:37980.03 stddev:83509.19 (219.9%) stddev-sans-first:83666.90 20:04:53 INFO - PROCESS | 28132 | Values: 515.5 530.7 562.0 579.1 603.9 28708.7 29380.9 36677.3 36913.0 37035.8 39365.0 39749.6 39822.8 39911.4 40201.8 7330.5 8341.1 8520.7 8538.1 8543.5 7362.6 7488.0 9839.9 10074.5 10133.6 9964.9 9966.1 10055.7 10063.5 10072.5 9798.1 9879.2 9888.8 9890.2 9892.5 9760.5 9869.6 9921.1 9928.3 9931.1 39890.8 40135.8 40148.2 40249.4 40275.6 3127.2 3298.4 3308.2 3374.2 3442.1 29796.6 29924.1 30166.0 30260.4 30880.0 3957.7 4071.9 4081.7 4092.6 4118.7 224450.0 225423.0 225909.9 226171.0 226852.0 53390.3 55087.4 56954.4 57407.1 61351.4 55015.0 55567.7 55703.2 55922.4 55941.4 15119.8 15364.5 15383.7 15383.8 15384.7 11392.2 11411.8 11449.0 11451.6 11453.8 19312.4 20234.5 20286.6 20307.5 20343.9 7690.3 7756.1 7922.2 7923.5 7942.4 955.7 1024.5 1079.8 1112.8 1116.7 28366.7 28509.7 28884.3 28988.9 29115.4 1014.9 1043.5 1045.5 1055.8 1103.8 14798.7 15142.8 15356.7 15423.9 16115.0 392690.0 398189.0 399393.0 400491.0 401258.0 54342.7 54405.7 54861.7 54874.7 54909.0 1275.7 1304.4 1320.1 1323.1 1337.7 29277.0 30291.7 30473.0 31283.8 33317.3 42832.6 44633.3 48132.8 48165.0 49180.0 303037.0 304490.0 306850.0 307511.5 307829.0 40399.4 40612.0 41357.8 41596.4 41620.4 44433.8 44551.3 44606.8 44963.0 45807.0 36883.4 36975.6 37552.6 38112.8 38456.0 37847.2 38498.2 38605.4 38736.0 38767.0 35756.3 35789.5 36175.0 38296.2 39563.2 30227.0 32800.0 33262.8 33510.3 33755.0 24996.0 25053.6 25271.9 25325.0 25754.2 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#2] jquery.html Cycles:180 Average:25678.52 Median:4924.96 stddev:80830.66 (1641.2%) stddev-sans-first:81035.06 20:04:53 INFO - PROCESS | 28132 | Values: 362.2 366.5 366.6 366.7 371.4 13350.3 13634.5 15179.1 15903.6 16789.6 14550.0 15318.4 15554.2 15671.7 16440.8 5264.1 5470.9 5478.0 5481.6 5486.6 3771.4 3854.4 5375.5 5464.3 5737.0 5756.9 5818.4 5895.8 5897.9 5898.8 5746.9 5839.5 5904.7 5908.1 5912.6 4724.9 4923.9 4926.0 5184.0 5211.7 11748.6 11974.3 13313.4 18739.4 18820.1 1947.5 2056.1 2064.9 2095.2 2130.4 8359.7 8362.0 8835.5 9030.3 9043.1 1744.5 1838.6 1851.4 1870.5 1886.9 54707.5 54820.5 55241.4 56081.7 56141.7 9463.9 9842.7 10180.1 10220.9 10315.3 13248.9 13312.5 13371.7 13398.9 13420.7 7226.4 7291.5 7294.0 7325.7 7334.7 6983.1 7086.8 7151.8 7242.3 7244.6 4384.7 4414.2 4415.4 4457.3 4497.2 1698.6 1705.8 1728.0 1764.1 1775.9 890.1 920.3 933.3 941.3 953.2 13365.7 15225.8 15330.8 15468.0 15801.6 861.5 909.1 910.1 924.6 992.8 9234.7 9871.0 9932.7 9943.3 10187.7 366255.0 371599.0 558391.0 560707.0 566757.0 69318.7 72065.6 72386.3 72484.6 73128.0 1108.3 1130.9 1135.9 1143.1 1149.0 14685.3 15024.4 15095.7 15190.5 15406.8 31542.8 32203.6 33968.7 35362.3 35785.5 42040.2 42650.4 42733.1 43686.3 44417.3 6863.6 7051.4 7311.6 7361.4 7370.0 9547.7 10530.7 10772.7 10798.8 11246.9 8764.8 9264.0 9325.7 9479.7 9702.6 8686.7 9548.9 9552.6 10016.7 10237.6 9452.2 10009.3 10147.0 10147.9 10467.4 7170.5 7245.6 7283.1 7292.9 7385.7 7528.7 9432.2 9546.7 9630.0 10147.1 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#3] mootools.html Cycles:180 Average:5286.78 Median:6389.36 stddev:2684.30 (42.0%) stddev-sans-first:2675.25 20:04:53 INFO - PROCESS | 28132 | Values: 1317.4 1410.9 1414.9 1551.8 1734.1 6769.6 7261.9 7419.1 7422.0 7438.2 7261.6 7411.6 7416.9 7437.1 7469.6 1944.8 1989.1 2222.2 2258.7 2270.1 2278.6 2288.9 2291.0 2291.6 2295.0 2197.6 2273.7 2276.9 2278.5 2280.0 2214.2 2222.3 2297.2 2311.7 2317.9 2252.6 2258.2 2259.1 2263.6 2313.9 7561.5 7675.3 7676.2 7676.9 7692.4 4482.6 4558.5 4567.7 4570.1 4571.1 3001.9 3070.2 3106.0 3111.2 3167.6 1006.0 1033.7 1047.9 1056.4 1104.5 9867.5 9916.8 9926.4 9940.7 9942.8 3932.9 4068.5 4106.8 4110.3 4114.2 8303.0 8340.3 8346.3 8381.6 8414.7 4613.8 4622.4 4624.0 4631.6 4635.0 4235.1 4277.2 4286.7 4288.8 4289.5 3209.1 3241.4 3306.0 3481.5 3603.1 1034.8 1099.0 1099.9 1103.2 1110.3 1292.7 1302.4 1314.8 1334.3 1340.0 6804.6 6985.3 6990.1 7043.2 7046.8 1087.0 1113.5 1120.3 1130.1 1136.3 5724.3 5821.8 5831.2 5848.0 5863.5 8706.8 8931.6 8946.2 8959.9 9038.4 8952.4 9103.4 9104.9 9110.8 9123.3 6952.5 7294.8 7325.3 7398.0 7402.6 7237.9 7292.0 7359.9 7383.7 7387.9 8191.0 8238.5 8381.7 8446.2 8453.5 8455.9 8533.1 8658.8 8697.2 8712.8 6817.1 6901.4 6917.7 6937.4 6968.3 6424.6 6574.8 6595.4 6739.6 6741.4 6454.7 6501.9 6635.3 6649.6 6673.9 6522.3 6565.8 6669.8 6691.2 6775.2 6726.9 6778.9 6795.8 6800.1 6804.8 6031.6 6164.7 6200.4 6205.1 6206.2 6369.6 6409.1 6430.8 6449.0 6451.7 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#4] prototype.html Cycles:180 Average:5291.53 Median:5920.20 stddev:1574.93 (26.6%) stddev-sans-first:1534.82 20:04:53 INFO - PROCESS | 28132 | Values: 337.5 340.7 341.2 345.6 349.0 5863.3 5927.9 5935.1 5963.3 5997.1 5647.0 5731.2 5836.1 5886.9 5912.6 4583.7 4602.6 4606.9 4610.7 4614.1 4373.0 4608.7 4609.9 4611.5 4613.1 4409.6 4451.6 4515.8 4518.7 4531.0 4503.4 4512.7 4515.4 4524.5 4528.1 4005.6 4008.0 4009.7 4017.3 4023.0 5464.3 5594.6 5604.3 5607.4 5625.4 5296.9 5316.0 5319.7 5322.9 5336.6 6230.5 6241.8 6246.5 6250.5 6255.6 4413.0 4415.3 4424.0 4429.4 4444.6 6343.7 6406.1 6537.7 6571.3 6584.1 4624.7 4625.2 4625.8 4628.2 4635.7 4672.9 4677.9 4685.2 4687.7 4696.8 5324.1 5337.2 5342.2 5342.8 5346.4 6085.5 6280.2 6315.7 6324.7 6334.0 1622.5 1658.0 1658.1 1658.7 1658.8 1091.1 1101.6 1109.9 1136.7 1141.3 5951.0 5957.5 5960.7 5962.3 5971.2 6486.3 6486.9 6488.0 6491.4 6497.5 5748.3 5790.8 5820.0 5844.7 5850.1 3436.8 3515.2 3519.8 3521.2 3525.1 6797.2 6800.8 6802.0 6807.0 6810.6 6536.8 6671.5 6683.9 6684.0 6686.0 6784.5 6786.7 6798.4 6799.3 6803.4 6523.7 6526.6 6537.2 6543.9 6546.3 6317.0 6445.8 6453.2 6459.1 6465.9 6782.7 6785.4 6785.8 6790.3 6794.4 4619.1 4619.5 4623.8 4624.7 4628.9 6284.7 6500.8 6520.4 6532.6 6556.1 6375.0 6383.8 6391.7 6395.1 6400.2 6360.1 6371.7 6431.0 6436.2 6441.2 6119.6 6214.3 6222.4 6249.3 6251.8 6361.4 6374.0 6379.6 6386.9 6387.3 6226.2 6228.8 6232.9 6236.4 6238.4 20:04:53 INFO - PROCESS | 28132 | 20:04:53 INFO - PROCESS | 28132 | [#5] yui.html Cycles:180 Average:13958.24 Median:47266.53 stddev:16461.11 (34.8%) stddev-sans-first:16476.98 20:04:53 INFO - PROCESS | 28132 | Values: 656.5 703.1 711.4 801.4 852.7 12394.1 12494.6 12498.1 12552.2 12570.7 11079.3 11276.8 11284.4 11287.5 11321.2 636.5 764.2 778.3 785.0 786.9 778.9 783.6 785.5 785.6 785.8 668.0 820.8 825.0 825.6 826.2 667.9 668.4 669.9 801.3 819.1 604.5 604.6 605.4 605.8 605.9 12483.3 12512.5 12523.7 12524.6 12533.6 11410.5 12162.3 12398.9 12594.8 12656.3 10494.7 10552.7 10563.5 10700.8 10746.2 3552.9 3585.6 3607.0 3614.3 3755.7 47230.0 47245.3 47287.8 47421.3 47490.3 9920.6 10018.2 10213.5 10289.7 10466.6 18452.8 18528.0 18596.3 18620.3 18627.1 7171.1 7215.0 7328.0 7411.6 7449.7 4253.1 4309.7 4335.8 4345.1 4412.2 2963.7 3006.5 3009.1 3009.7 3010.0 518.5 530.6 536.2 546.5 550.3 535.0 572.9 630.8 635.5 653.4 8049.3 8096.8 8134.3 8353.9 8363.5 675.3 682.6 684.7 687.9 691.4 3974.8 4002.6 4092.9 4207.4 4217.3 59744.4 60686.7 60787.0 60933.7 60940.4 51526.7 52521.5 52667.5 52724.7 52736.2 47156.8 47821.8 47919.5 48261.8 48303.5 8113.5 8120.9 8233.1 8327.1 8334.6 35580.3 35881.3 36384.8 36396.5 36429.5 41858.8 47029.1 47220.5 47563.0 47742.8 10076.3 11091.3 11108.5 11216.4 11564.6 12412.3 12852.4 12854.3 13115.2 13168.9 11871.3 12249.6 12534.6 12618.9 12627.8 11545.9 11869.2 11894.3 12036.7 12277.3 11414.5 11735.9 11769.8 11903.5 12180.5 9526.9 9624.5 9708.8 9921.8 9946.1 8696.9 8706.8 8903.4 9444.6 10057.0 20:04:53 INFO - PROCESS | 28132 | -------- Summary: end -------- 20:04:53 INFO - PROCESS | 28132 | 20:04:54 INFO - TEST-INFO | 28132: exit 0 20:04:54 INFO - TEST-OK | dromaeo_css | took 1111812ms 20:04:54 INFO - TEST-START | kraken 20:04:54 INFO - operating with platform_type : linux_ 20:04:54 INFO - Initialising browser for kraken test... 20:04:54 INFO - TEST-INFO | started process 28333 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOF291r/profile http://localhost:55990/getInfo.html) 20:04:58 INFO - PROCESS | 28333 | __metrics Screen width/height:1600/1200 20:04:58 INFO - PROCESS | 28333 | colorDepth:24 20:04:58 INFO - PROCESS | 28333 | Browser inner width/height: 1024/697 20:04:58 INFO - PROCESS | 28333 | __metrics 20:04:58 INFO - PROCESS | 28333 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:04:58 INFO - PROCESS | 28333 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:04:59 INFO - TEST-INFO | 28333: exit 0 20:04:59 INFO - Browser initialized. 20:04:59 INFO - Running cycle 1/1 for kraken test... 20:04:59 INFO - TEST-INFO | started process 28412 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOF291r/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:10 INFO - PROCESS | 28412 | RSS: Main: 150622208 20:05:10 INFO - PROCESS | 28412 | 20:05:13 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-beat-detection) 20:05:13 INFO - PROCESS | 28412 | RSS: Main: 187060224 20:05:13 INFO - PROCESS | 28412 | 20:05:16 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-dft) 20:05:17 INFO - PROCESS | 28412 | RSS: Main: 176443392 20:05:17 INFO - PROCESS | 28412 | 20:05:19 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-fft) 20:05:20 INFO - PROCESS | 28412 | RSS: Main: 161591296 20:05:20 INFO - PROCESS | 28412 | 20:05:22 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-oscillator) 20:05:22 INFO - PROCESS | 28412 | RSS: Main: 162455552 20:05:22 INFO - PROCESS | 28412 | 20:05:25 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:05:25 INFO - PROCESS | 28412 | RSS: Main: 165928960 20:05:25 INFO - PROCESS | 28412 | 20:05:28 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-darkroom) 20:05:29 INFO - PROCESS | 28412 | RSS: Main: 167059456 20:05:29 INFO - PROCESS | 28412 | 20:05:32 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-desaturate) 20:05:33 INFO - PROCESS | 28412 | RSS: Main: 165851136 20:05:33 INFO - PROCESS | 28412 | 20:05:35 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55990/tests/kraken/driver.html?testName=json-parse-financial) 20:05:36 INFO - PROCESS | 28412 | RSS: Main: 166207488 20:05:36 INFO - PROCESS | 28412 | 20:05:38 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:05:38 INFO - PROCESS | 28412 | RSS: Main: 177242112 20:05:38 INFO - PROCESS | 28412 | 20:05:40 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:05:41 INFO - PROCESS | 28412 | RSS: Main: 174215168 20:05:41 INFO - PROCESS | 28412 | 20:05:43 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:05:43 INFO - PROCESS | 28412 | RSS: Main: 180305920 20:05:43 INFO - PROCESS | 28412 | 20:05:46 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:46 INFO - PROCESS | 28412 | RSS: Main: 189775872 20:05:46 INFO - PROCESS | 28412 | 20:05:49 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:05:49 INFO - PROCESS | 28412 | RSS: Main: 187392000 20:05:49 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55990/tests/kraken/driver.html?testName=ai-astar) 20:05:51 INFO - PROCESS | 28412 | RSS: Main: 244133888 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | __start_tp_report 20:05:51 INFO - PROCESS | 28412 | _x_x_mozilla_page_load 20:05:51 INFO - PROCESS | 28412 | _x_x_mozilla_page_load_details 20:05:51 INFO - PROCESS | 28412 | |i|pagename|runs| 20:05:51 INFO - PROCESS | 28412 | |0;ai-astar;109;111;105;108;112;110;100;109;110;109 20:05:51 INFO - PROCESS | 28412 | |1;audio-beat-detection;154;128;152;171;129;153;151;127;164;127 20:05:51 INFO - PROCESS | 28412 | |2;audio-dft;161;161;161;160;162;160;160;163;160;162 20:05:51 INFO - PROCESS | 28412 | |3;audio-fft;71;71;101;91;73;73;76;112;89;71 20:05:51 INFO - PROCESS | 28412 | |4;audio-oscillator;96;96;134;96;96;96;138;96;96;137 20:05:51 INFO - PROCESS | 28412 | |5;imaging-gaussian-blur;109;109;110;109;110;110;109;108;109;109 20:05:51 INFO - PROCESS | 28412 | |6;imaging-darkroom;145;146;146;145;146;145;146;146;145;146 20:05:51 INFO - PROCESS | 28412 | |7;imaging-desaturate;96;95;95;95;97;96;96;96;95;96 20:05:51 INFO - PROCESS | 28412 | |8;json-parse-financial;56;56;57;57;55;56;56;64;54;53 20:05:51 INFO - PROCESS | 28412 | |9;json-stringify-tinderbox;67;67;67;68;68;68;68;69;68;68 20:05:51 INFO - PROCESS | 28412 | |10;stanford-crypto-aes;80;81;82;82;83;82;82;82;82;83 20:05:51 INFO - PROCESS | 28412 | |11;stanford-crypto-ccm;119;115;121;121;131;126;116;124;114;115 20:05:51 INFO - PROCESS | 28412 | |12;stanford-crypto-pbkdf2;142;136;143;140;140;130;139;138;142;138 20:05:51 INFO - PROCESS | 28412 | |13;stanford-crypto-sha256-iterative;66;65;67;65;66;64;67;67;66;66 20:05:51 INFO - PROCESS | 28412 | __end_tp_report 20:05:51 INFO - PROCESS | 28412 | __start_cc_report 20:05:51 INFO - PROCESS | 28412 | _x_x_mozilla_cycle_collect,978 20:05:51 INFO - PROCESS | 28412 | __end_cc_report 20:05:51 INFO - PROCESS | 28412 | __startTimestamp1452917151586__endTimestamp 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | ------- Summary: start ------- 20:05:51 INFO - PROCESS | 28412 | Number of tests: 14 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.50 stddev:3.47 (3.2%) stddev-sans-first:3.67 20:05:51 INFO - PROCESS | 28412 | Values: 109.0 111.0 105.0 108.0 112.0 110.0 100.0 109.0 110.0 109.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.50 stddev:16.52 (10.8%) stddev-sans-first:17.24 20:05:51 INFO - PROCESS | 28412 | Values: 154.0 128.0 152.0 171.0 129.0 153.0 151.0 127.0 164.0 127.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 20:05:51 INFO - PROCESS | 28412 | Values: 161.0 161.0 161.0 160.0 162.0 160.0 160.0 163.0 160.0 162.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#3] audio-fft Cycles:10 Average:82.80 Median:73.00 stddev:14.70 (20.1%) stddev-sans-first:14.96 20:05:51 INFO - PROCESS | 28412 | Values: 71.0 71.0 101.0 91.0 73.0 73.0 76.0 112.0 89.0 71.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:96.00 stddev:19.51 (20.3%) stddev-sans-first:20.19 20:05:51 INFO - PROCESS | 28412 | Values: 96.0 96.0 134.0 96.0 96.0 96.0 138.0 96.0 96.0 137.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 20:05:51 INFO - PROCESS | 28412 | Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 108.0 109.0 109.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:05:51 INFO - PROCESS | 28412 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 145.0 146.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:05:51 INFO - PROCESS | 28412 | Values: 96.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 95.0 96.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.95 (5.3%) stddev-sans-first:3.13 20:05:51 INFO - PROCESS | 28412 | Values: 56.0 56.0 57.0 57.0 55.0 56.0 56.0 64.0 54.0 53.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:05:51 INFO - PROCESS | 28412 | Values: 67.0 67.0 67.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.88 (1.1%) stddev-sans-first:0.60 20:05:51 INFO - PROCESS | 28412 | Values: 80.0 81.0 82.0 82.0 83.0 82.0 82.0 82.0 82.0 83.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#11] stanford-crypto-ccm Cycles:10 Average:120.20 Median:121.00 stddev:5.55 (4.6%) stddev-sans-first:5.87 20:05:51 INFO - PROCESS | 28412 | Values: 119.0 115.0 121.0 121.0 131.0 126.0 116.0 124.0 114.0 115.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:140.00 stddev:3.77 (2.7%) stddev-sans-first:3.81 20:05:51 INFO - PROCESS | 28412 | Values: 142.0 136.0 143.0 140.0 140.0 130.0 139.0 138.0 142.0 138.0 20:05:51 INFO - PROCESS | 28412 | 20:05:51 INFO - PROCESS | 28412 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 20:05:51 INFO - PROCESS | 28412 | Values: 66.0 65.0 67.0 65.0 66.0 64.0 67.0 67.0 66.0 66.0 20:05:51 INFO - PROCESS | 28412 | -------- Summary: end -------- 20:05:51 INFO - PROCESS | 28412 | 20:05:52 INFO - TEST-INFO | 28412: exit 0 20:05:52 INFO - TEST-OK | kraken | took 58239ms 20:05:52 INFO - TEST-START | v8_7 20:05:52 INFO - operating with platform_type : linux_ 20:05:52 INFO - Initialising browser for v8_7 test... 20:05:52 INFO - TEST-INFO | started process 28660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHTYCBB/profile http://localhost:55990/getInfo.html) 20:05:56 INFO - PROCESS | 28660 | __metrics Screen width/height:1600/1200 20:05:56 INFO - PROCESS | 28660 | colorDepth:24 20:05:56 INFO - PROCESS | 28660 | Browser inner width/height: 1024/697 20:05:56 INFO - PROCESS | 28660 | __metrics 20:05:56 INFO - PROCESS | 28660 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:05:56 INFO - PROCESS | 28660 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:05:57 INFO - TEST-INFO | 28660: exit 0 20:05:57 INFO - Browser initialized. 20:05:57 INFO - Running cycle 1/1 for v8_7 test... 20:05:57 INFO - TEST-INFO | started process 28742 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHTYCBB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:09 INFO - PROCESS | 28742 | RSS: Main: 150974464 20:06:09 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | Cycle 1(1): loaded http://localhost:55990/tests/v8_7/run.html (next: http://localhost:55990/tests/v8_7/run.html) 20:06:31 INFO - PROCESS | 28742 | RSS: Main: 549003264 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | __start_tp_report 20:06:31 INFO - PROCESS | 28742 | _x_x_mozilla_page_load 20:06:31 INFO - PROCESS | 28742 | _x_x_mozilla_page_load_details 20:06:31 INFO - PROCESS | 28742 | |i|pagename|runs| 20:06:31 INFO - PROCESS | 28742 | |0;Richards;167.81339150864238 20:06:31 INFO - PROCESS | 28742 | |1;DeltaBlue;188.89308651303364 20:06:31 INFO - PROCESS | 28742 | |2;Encrypt;279.87685418415896 20:06:31 INFO - PROCESS | 28742 | |3;Decrypt;5164.948453608247 20:06:31 INFO - PROCESS | 28742 | |4;RayTrace;1118.5682326621925 20:06:31 INFO - PROCESS | 28742 | |5;Earley;783.868441660141 20:06:31 INFO - PROCESS | 28742 | |6;Boyer;12395.061728395061 20:06:31 INFO - PROCESS | 28742 | |7;RegExp;42291.666666666664 20:06:31 INFO - PROCESS | 28742 | |8;Splay;585.805700988947 20:06:31 INFO - PROCESS | 28742 | |9;NavierStokes;4830.917874396136 20:06:31 INFO - PROCESS | 28742 | __end_tp_report 20:06:31 INFO - PROCESS | 28742 | __startTimestamp1452917191790__endTimestamp 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | ------- Summary: start ------- 20:06:31 INFO - PROCESS | 28742 | Number of tests: 10 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 167.8 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#1] DeltaBlue Cycles:1 Average:188.89 Median:188.89 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 188.9 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 279.9 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 5164.9 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#4] RayTrace Cycles:1 Average:1118.57 Median:1118.57 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 1118.6 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#5] Earley Cycles:1 Average:783.87 Median:783.87 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 783.9 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 12395.1 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#7] RegExp Cycles:1 Average:42291.67 Median:42291.67 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 42291.7 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#8] Splay Cycles:1 Average:585.81 Median:585.81 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 585.8 20:06:31 INFO - PROCESS | 28742 | 20:06:31 INFO - PROCESS | 28742 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:06:31 INFO - PROCESS | 28742 | Values: 4830.9 20:06:31 INFO - PROCESS | 28742 | -------- Summary: end -------- 20:06:31 INFO - PROCESS | 28742 | 20:06:32 INFO - TEST-INFO | 28742: exit 0 20:06:32 INFO - TEST-OK | v8_7 | took 40225ms 20:06:32 INFO - SUITE-END | took 1210s 20:06:32 INFO - Completed test suite (00:20:10) 20:06:32 INFO - Working with test: dromaeo_css 20:06:32 INFO - Generating results file: dromaeo_css 20:06:32 INFO - Working with test: kraken 20:06:32 INFO - Generating results file: kraken 20:06:32 INFO - javascript benchmark 20:06:32 INFO - Working with test: v8_7 20:06:32 INFO - Generating results file: v8_7 20:06:32 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:06:32 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 20:06:32 INFO - process_Request line: dromaeo_css 6791.40 graph.html#tests=[[72,64,35]] 20:06:32 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:06:32 INFO - process_Request line: kraken 1487.30 graph.html#tests=[[232,64,35]] 20:06:32 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:06:32 INFO - process_Request line: v8_7 20072.22 graph.html#tests=[[230,64,35]] 20:06:32 INFO - RETURN: dromaeo_css: 6791.40 20:06:32 INFO - RETURN: kraken: 1487.30 20:06:32 INFO - RETURN: v8_7: 20072.22 20:06:32 INFO - javascript benchmark 20:06:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3088.4286407014706, 3111.2377467520455, 3158.873645054198, 3171.7462602991764, 3174.1905814017423, 4949.307097006413, 4951.851444456667, 4955.727434991083, 4996.075725990694, 5010.423801262856, 5058.11482990477, 5064.974675126628, 5089.3638295213095, 5130.256112863642, 5151.021305951876, 4596.287575425806, 4603.917420848332, 4618.584327410533, 4656.8602941911795, 4719.174144524694, 4703.482616912137, 4713.717176969376, 4741.8103275868925, 4759.357486739298, 4759.524047595248, 4542.205114105035, 4578.45058592971, 4629.513901040393, 4638.79125439356, 4644.024754801496, 4587.931181032287, 4611.146937816515, 4611.44662640482, 4619.8152073917, 4655.3947986761505, 4586.954130458686, 4594.1271158479785, 4596.448426188846, 4606.838760643362, 4638.397008388922, 4753.0, 4814.590759785422, 4850.442199147108, 4871.926921096187, 4873.707577545359, 5233.188855727369, 5236.21456781482, 5240.187770895517, 5242.0, 5262.289590905217, 5275.28783614211, 5276.12943864262, 5291.391489978625, 5303.814366497154, 5358.866028349323, 5089.982003599295, 5090.083784918713, 5092.490750924915, 5132.512411320956, 5137.255098010767, 5464.836054918359, 5493.093639549509, 5508.944910550843, 5514.531264842453, 5522.502974732293, 5155.639105262596, 5255.605829562798, 5320.907262480851, 5330.227117068003, 5369.704666243316, 5402.91895621566, 5497.587680923947, 5498.120300751861, 5503.11950087984, 5538.16927460876, 5362.570994320523, 5369.221462887859, 5372.328458942632, 5377.274068000848, 5432.348118225759, 5258.8159414420315, 5340.626156169031, 5354.598405119632, 5383.919241211385, 5398.730063496888, 4263.829446822155, 4268.338407546773, 4273.0, 4286.61420472159, 4309.806058727365, 3805.219929914361, 3812.4662547243406, 3820.751651142667, 3843.9231215375535, 3852.1332700142243, 4984.700917944862, 4996.675216110941, 5047.318611987408, 5052.292679024939, 5057.266696329012, 5428.022955867982, 5435.239066530688, 5453.890922181614, 5455.263539422127, 5481.150421684645, 5067.315912351859, 5075.771590278372, 5077.796888124433, 5079.97460012705, 5124.538791508782, 4589.931151032737, 4608.700434471749, 4666.160091183619, 4670.276107203389, 4705.082508910729, 5557.472040156179, 5560.193771903132, 5573.804916827973, 5577.972110139423, 5588.804391846266, 5388.137897936312, 5395.46045395473, 5397.136458166675, 5397.730113494231, 5444.373897001737, 5460.5085542301385, 5471.316085489314, 5489.862753431196, 5541.251930989426, 5555.138953462219, 5357.678539287655, 5365.490278423544, 5376.435474275301, 5379.811706590407, 5379.919301210563, 5343.3587969443915, 5427.538659214011, 5429.40276569585, 5444.292242008513, 5504.201890725903, 5229.21561765723, 5298.284731561344, 5321.707306098202, 5333.626646134733, 5375.623706340675, 5292.9206061908335, 5293.920591191212, 5299.231611416246, 5302.893942121059, 5357.785688572413, 5098.515641014098, 5180.067587834226, 5222.921656175236, 5225.346831646044, 5230.084735171406, 5317.680939143664, 5321.760520776652, 5348.679079255257, 5394.163904594794, 5398.40617532079, 5166.535011848951, 5172.844814655567, 5182.274481572658, 5185.066687996197, 5192.766325515286], "unit": "score", "name": "dojo.html", "value": 4994.81901557718}, {"lowerIsBetter": false, "replicates": [515.5128403658545, 530.6921985248556, 561.9747111379986, 579.1052823387867, 603.9491285163814, 28708.712912870866, 29380.853095734517, 36677.26645467093, 36913.0, 37035.81482092592, 39365.0, 39749.60250397495, 39822.8008859956, 39911.40132898001, 40201.798991005075, 7330.523515971445, 8341.124181960882, 8520.701775437861, 8538.103499132563, 8543.530105844176, 7362.5582465052, 7487.962560187191, 9839.852402213972, 10074.546645400938, 10133.594656213743, 9964.90035099647, 9966.103050725433, 10055.69832905014, 10063.496825158749, 10072.546735396889, 9798.118169364756, 9879.209663226924, 9888.752781180456, 9890.20878329732, 9892.50537473127, 9760.4631745254, 9869.60521579136, 9921.10710036093, 9928.305018648698, 9931.056549627774, 39890.80054599737, 40135.7993210035, 40148.197036059406, 40249.396259056135, 40275.59724402748, 3127.18693139783, 3298.3897978873983, 3308.1894935740656, 3374.173327534745, 3442.1394651337164, 29796.553051704243, 29924.102276931728, 30166.0, 30260.394792104034, 30880.0, 3957.70618236099, 4071.8982025449304, 4081.7346872453195, 4092.6112019358116, 4118.670506359484, 224450.0, 225423.0, 225909.87045064833, 226171.0, 226852.0, 53390.262681611915, 55087.44912550903, 56954.43045569574, 57407.13889291664, 61351.38648613546, 55015.0, 55567.722161388934, 55703.164452533245, 55922.44077559172, 55941.440585594435, 15119.773203401957, 15364.539063828102, 15383.692326153414, 15383.846161538466, 15384.692306153815, 11392.20254582188, 11411.828822567668, 11449.0, 11451.59919402817, 11453.770924581628, 19312.42062738092, 20234.494137646383, 20286.59426811485, 20307.492312692302, 20343.898280508798, 7690.346320562703, 7756.121939030485, 7922.247386498273, 7923.524588524707, 7942.404319676048, 955.6894009446958, 1024.4826362686945, 1079.7570546627103, 1112.8330750387345, 1116.7040734205443, 28366.71633283682, 28509.71490285112, 28884.27789305284, 28988.855055724587, 29115.41769164605, 1014.8629934958686, 1043.473046111724, 1045.5086109528509, 1055.762453447968, 1103.8068338040812, 14798.704025919636, 15142.848571514363, 15356.692866142837, 15423.922880385526, 16115.0, 392690.0, 398189.0, 399393.0, 400491.0, 401258.0, 54342.72828635832, 54405.727971360684, 54861.725691371284, 54874.72562637161, 54909.0, 1275.661949583361, 1304.4346783859407, 1320.069351107467, 1323.1135139456587, 1337.699017721005, 29277.0, 30291.69708302889, 30473.0, 31283.84358078195, 33317.33365332728, 42832.5716742841, 44633.33050004188, 48132.7593362031, 48165.0, 49180.0, 303037.0, 304490.0, 306850.0, 307511.4624426864, 307829.0, 40399.39400909047, 40612.0, 41357.79321103375, 41596.37605435981, 41620.37569436521, 44433.77783111064, 44551.33173002472, 44606.776966114965, 44963.0, 45807.0, 36883.44674829826, 36975.63024369722, 37552.624473756005, 38112.809435952644, 38456.0, 37847.2430551393, 38498.2300353997, 38605.42091868568, 38736.0, 38767.0, 35756.28487430185, 35789.46315805213, 36175.0, 38296.2340753189, 39563.20873582455, 30227.0, 32799.964098548684, 33262.833685831414, 33510.32979340448, 33755.0, 24996.0, 25053.624195636716, 25271.87364063168, 25325.0, 25754.227373178834], "unit": "score", "name": "ext.html", "value": 18897.954065038917}, {"lowerIsBetter": false, "replicates": [362.24110488526526, 366.541822721598, 366.5912507554078, 366.68465119996796, 371.4187296880382, 13350.265735384573, 13634.522791702293, 15179.089254644716, 15903.602409939756, 16789.580260493494, 14550.0, 15318.387264509407, 15554.200243956084, 15671.686566268669, 16440.83559164408, 5264.131418315983, 5470.9452905471035, 5478.041342765, 5481.561475081984, 5486.643368181076, 3771.377722675755, 3854.4411060396224, 5375.516203541681, 5464.26232458617, 5737.0, 5756.942430575704, 5818.447247511501, 5895.764169433218, 5897.852553686149, 5898.7640494380175, 5746.942530574704, 5839.474447299764, 5904.7047647617665, 5908.14331921869, 5912.615679980809, 4724.929126063112, 4923.926141107886, 4926.0, 5184.015037142931, 5211.661242019294, 11748.588799392066, 11974.34141122238, 13313.40089695966, 18739.437816865517, 18820.117988201207, 1947.5325921778813, 2056.0542150610736, 2064.9277275295444, 2095.224766836265, 2130.3502431758307, 8359.665613375457, 8361.95819020907, 8835.514046727427, 9030.322725795526, 9043.050479699668, 1744.4592176425222, 1838.5679365349133, 1851.3982955539368, 1870.4669169286824, 1886.9339573115012, 54707.45292547103, 54820.45179548193, 55241.44758552443, 56081.71959140219, 56141.71929140369, 9463.858042129374, 9842.65550705722, 10180.134688551409, 10220.897791021995, 10315.27793054479, 13248.867511324956, 13312.467501300032, 13371.665708357368, 13398.933005334911, 13420.731585368238, 7226.421886249087, 7291.52605080668, 7293.9635301823155, 7325.743598974117, 7334.743283985142, 6983.057287266256, 7086.787396378117, 7151.821204469826, 7242.311980361857, 7244.565326080452, 4384.6711496637245, 4414.168120230132, 4415.448068991376, 4457.2645513489915, 4497.190505709003, 1698.558374822555, 1705.8123606403285, 1727.956801079983, 1764.109124891947, 1775.8756887017785, 890.1276748786225, 920.332758749901, 933.281373342536, 941.2846236860036, 953.2421724728857, 13365.732685346238, 15225.771613425808, 15330.770038449433, 15468.0, 15801.604959876095, 861.4751889156158, 909.0909090909091, 910.1217325281135, 924.5654542365078, 992.8113658405024, 9234.676786312446, 9870.950645246729, 9932.652357167464, 9943.30396872212, 10187.683606238492, 366255.0, 371599.0, 558391.0, 560707.0, 566757.0, 69318.65340673365, 72065.6396718013, 72386.27613723901, 72484.55030899352, 73128.0, 1108.3239224073309, 1130.949107290174, 1135.8977692007593, 1143.1426430177366, 1149.0462915779883, 14685.339159737623, 15024.399024039354, 15095.698086037997, 15190.468333608713, 15406.768898466307, 31542.842285788425, 32203.62635938663, 33968.66031339655, 35362.292754144255, 35785.46321805227, 42040.1591968165, 42650.360244596974, 42733.145337092465, 43686.344704828814, 44417.33373999328, 6863.622500762506, 7051.365377116084, 7311.634418278958, 7361.374283185775, 7370.041894553674, 9547.65081221008, 10530.736731581772, 10772.730681733019, 10798.812130665778, 11246.887531124585, 8764.824703505767, 9263.953680231556, 9325.673601423918, 9479.668211612561, 9702.563384647567, 8686.695965641173, 9548.949615542424, 9552.617895284111, 10016.749581260527, 10237.641682541373, 9452.196563292197, 10009.349392289478, 10147.036031576989, 10147.949260253947, 10467.371957682564, 7170.462215333767, 7245.5652660840515, 7283.053203083565, 7292.927070729224, 7385.7045718170675, 7528.736494222676, 9432.245420366491, 9546.665866694633, 9630.0, 10147.137493312855], "unit": "score", "name": "jquery.html", "value": 7970.419284809354}, {"lowerIsBetter": false, "replicates": [1317.4137508808572, 1410.858914108589, 1414.9221792801395, 1551.7517197248442, 1734.080937103335, 6769.593824370535, 7261.927380726192, 7419.109706835187, 7421.9628901855485, 7438.218987006368, 7261.636918154098, 7411.629418529079, 7416.888746668791, 7437.144728356241, 7469.551826890377, 1944.7957964413745, 1989.094961792381, 2222.211115054157, 2258.7402448718362, 2270.14869423966, 2278.5784629843533, 2288.9084436622516, 2291.0377641390573, 2291.633338665814, 2294.9655755163685, 2197.571473562656, 2273.7044184256106, 2276.931692049233, 2278.5215104828007, 2280.0, 2214.2432671324145, 2222.3444083995178, 2297.2074634251157, 2311.6879221305076, 2317.8725170115636, 2252.583272094668, 2258.232201051634, 2259.1302348595746, 2263.6378179491203, 2313.8611683299055, 7561.546307221584, 7675.270849269311, 7676.193999630014, 7676.884846727304, 7692.423068269902, 4482.618977386894, 4558.521355257716, 4567.703099298535, 4570.063137056895, 4571.085782843445, 3001.8799248030055, 3070.186400603842, 3105.9844700776353, 3111.1910903165112, 3167.572377729, 1006.0392325329293, 1033.6588925654517, 1047.8899715529913, 1056.3503445381111, 1104.536094840161, 9867.457289849055, 9916.801663966753, 9926.404415735078, 9940.701778946643, 9942.751431214205, 3932.8623498177426, 4068.4507591475362, 4106.815193316308, 4110.321796903538, 4114.19773144234, 8303.00363956329, 8340.29107525855, 8346.332293416634, 8381.58092095405, 8414.747557573282, 4613.792379342937, 4622.399088118523, 4624.028953919715, 4631.560001799824, 4635.0, 4235.131797981407, 4277.230098582285, 4286.678499112579, 4288.828446862153, 4289.463817022872, 3209.1335339458215, 3241.3517296540313, 3306.04124803809, 3481.5125882376487, 3603.063203567039, 1034.849946757716, 1099.0, 1099.8680158381046, 1103.222228329042, 1110.3227031510771, 1292.6832925933206, 1302.3553341096217, 1314.8487923888683, 1334.3395019465427, 1340.0, 6804.591724496447, 6985.301469852974, 6990.09128813251, 7043.154821421463, 7046.788596342118, 1086.9945650271857, 1113.549012649878, 1120.3389999900098, 1130.0733398613058, 1136.2727854173336, 5724.25584673998, 5821.79623713168, 5831.154482599999, 5847.970760146172, 5863.5309175265875, 8706.825863482694, 8931.598078086501, 8946.239569636524, 8959.865602015974, 9038.367314288069, 8952.373333866566, 9103.408278461879, 9104.908950910538, 9110.772230694285, 9123.270138388913, 6952.5480843745, 7294.781156565312, 7325.340719335285, 7398.0, 7402.629868506553, 7237.855242895007, 7292.0, 7359.852802944019, 7383.741569045058, 7387.889181662172, 8191.0, 8238.50568965864, 8381.748547543584, 8446.239838414573, 8453.535055571756, 8455.915440845758, 8533.061363249913, 8658.826823463369, 8697.173768491983, 8712.78218044554, 6817.079694241214, 6901.447884169354, 6917.688704008432, 6937.375636192565, 6968.303169682991, 6424.646644434601, 6574.8356291091195, 6595.373439523238, 6739.629320387426, 6741.393274605309, 6454.677266136769, 6501.8699626008165, 6635.336466353519, 6649.60102393858, 6673.9332606673315, 6522.34776522344, 6565.835854103686, 6669.799906002828, 6691.230508491391, 6775.220849602359, 6726.8990965136545, 6778.93221067783, 6795.830104247236, 6800.149981252343, 6804.795856124324, 6031.577789554689, 6164.660943648142, 6200.410960958701, 6205.131281620486, 6206.193194884636, 6369.617822930639, 6409.102725618324, 6430.839229019312, 6448.967755161194, 6451.709673064817], "unit": "score", "name": "mootools.html", "value": 4381.516218888171}, {"lowerIsBetter": false, "replicates": [337.5072394304316, 340.71209827695594, 341.2152050284345, 345.5576861617129, 349.0279571393669, 5863.2964044314685, 5927.851803704904, 5935.109733539965, 5963.254593175853, 5997.100434934762, 5646.971765141168, 5731.197632331477, 5836.066229403296, 5886.882262354761, 5912.556558258127, 4583.724976501404, 4602.562756538124, 4606.907861842761, 4610.723356598598, 4614.123316569858, 4373.0, 4608.654350923677, 4609.907801843978, 4611.492735799059, 4613.054323863616, 4409.581089796464, 4451.5993560579545, 4515.7516336601475, 4518.728876267434, 4531.0, 4503.369528266046, 4512.706674066175, 4515.390422292981, 4524.502304746492, 4528.139653465831, 4005.619466150711, 4007.9779656187775, 4009.69927255457, 4017.31705610047, 4023.0344717267644, 5464.3442786865835, 5594.636348637367, 5604.299462567179, 5607.439256074401, 5625.38120806711, 5296.894062118775, 5316.043112239795, 5319.7340132993195, 5322.866928326784, 5336.599755018389, 6230.501559875199, 6241.843953901143, 6246.469050130744, 6250.531210159256, 6255.562110652256, 4412.977935110336, 4415.271480205763, 4423.955760442386, 4429.357743127261, 4444.599986001275, 6343.682815859234, 6406.071119687619, 6537.738490460376, 6571.2771595124495, 6584.144061272004, 4624.722516649012, 4625.190591646448, 4625.791839367236, 4628.190066738307, 4635.721856688542, 4672.859814205579, 4677.859664210079, 4685.226937555333, 4687.718736875799, 4696.8121275148615, 5324.068288049576, 5337.172738225504, 5342.171963345688, 5342.813001544927, 5346.358436987509, 6085.5435842312, 6280.183576135073, 6315.747370105236, 6324.747010119636, 6333.968330158412, 1622.4564770801678, 1657.9751303730454, 1658.1211957662458, 1658.6599747051825, 1658.7760652312024, 1091.0671375973586, 1101.6254473479055, 1109.9056580190613, 1136.6760473265244, 1141.2981016674685, 5951.0, 5957.523398128139, 5960.7019649017375, 5962.284525856925, 5971.164037034819, 6486.254080780676, 6486.902696459462, 6487.967560162169, 6491.383318584727, 6497.480201583862, 5748.281464816898, 5790.826275211751, 5820.039693450533, 5844.707764611752, 5850.063989761617, 3436.810975396377, 3515.2442224921765, 3519.788812671248, 3521.2253304273017, 3525.11872031992, 6797.150356205474, 6800.795976120724, 6802.0, 6807.047013418125, 6810.557313774589, 6536.758015977044, 6671.532992690465, 6683.899741503881, 6683.966580167068, 6686.030525573765, 6784.491163162783, 6786.694598743068, 6798.388145066869, 6799.3200679931615, 6803.387695107464, 6523.706433210422, 6526.641034742945, 6537.215534135934, 6543.901841472287, 6546.279909209888, 6316.968415157895, 6445.774397896239, 6453.225612926479, 6459.095726598374, 6465.903011454926, 6782.728690852508, 6785.423239024738, 6785.7624983127325, 6790.25307216196, 6794.388505034571, 4619.099275641218, 4619.538046195354, 4623.791929363119, 4624.722516649012, 4628.889066624053, 6284.654344011124, 6500.804975850732, 6520.413162815369, 6532.640704761284, 6556.114924485133, 6374.96812515953, 6383.787080454698, 6391.712372943136, 6395.136656551492, 6400.167978162809, 6360.109584658059, 6371.74513019474, 6431.035344698333, 6436.195475565554, 6441.194850643669, 6119.571629985859, 6214.316425193135, 6222.408871157233, 6249.312575616587, 6251.843703907439, 6361.395667411589, 6373.968130159319, 6379.553431259953, 6386.87226255463, 6387.297397286202, 6226.1905952227735, 6228.813135605939, 6232.937670623417, 6236.438720515175, 6238.376162383907], "unit": "score", "name": "prototype.html", "value": 4785.812088949714}, {"lowerIsBetter": false, "replicates": [656.5338609587193, 703.0789665538146, 711.3739908880185, 801.3749275565061, 852.6504133305347, 12394.070444716648, 12494.56269030583, 12498.125131240817, 12552.246865188095, 12570.68573285666, 11079.335239885593, 11276.830847537294, 11284.435778211076, 11287.49206285717, 11321.150913681466, 636.5162476517834, 764.2014095270456, 778.3228591125728, 784.9921500785005, 786.9173736757643, 778.8636988526985, 783.600363814453, 785.4619585583865, 785.6150486261719, 785.7839094249099, 667.9532432729711, 820.7742870710573, 824.9628766705513, 825.6408462318881, 826.1614461321764, 667.933206679333, 668.4318329419979, 669.8727241824038, 801.2748462641318, 819.1276290750392, 604.5224272824463, 604.6100265328838, 605.4248463959257, 605.8121982185537, 605.8879107365152, 12483.31341776202, 12512.499500019989, 12523.74952500954, 12524.624261272176, 12533.561325353568, 11410.54357825686, 12162.270263784201, 12398.938005310007, 12594.81107783384, 12656.344399562558, 10494.737631559196, 10552.736181595445, 10563.47182640865, 10700.839487407695, 10746.194035447295, 3552.8934131976084, 3585.569731632195, 3607.0, 3614.331348700499, 3755.7370984031127, 47230.0, 47245.29132063022, 47287.76356118232, 47421.28868066947, 47490.28764568534, 9920.553575089138, 10018.248631352677, 10213.540390682288, 10289.74275643115, 10466.63366782159, 18452.815471845377, 18528.0, 18596.25614975413, 18620.255189792526, 18627.06864656762, 7171.1394632644415, 7214.96392518034, 7328.047353843966, 7411.629418529052, 7449.702011919571, 4253.128108737701, 4309.698321117492, 4335.848245311399, 4345.065810850619, 4412.205802955499, 2963.703629637019, 3006.5490176473268, 3009.0972708187455, 3009.653889802657, 3010.036788227746, 518.4530320511897, 530.6259087343491, 536.1983834167944, 546.4835730234889, 550.3340957441541, 535.0129011972904, 572.9341125770507, 630.7508534128993, 635.4725577770439, 653.3629711031801, 8049.315808156372, 8096.757097287091, 8134.3085837703275, 8353.913991181107, 8363.456375335583, 675.3078094952713, 682.5597489619167, 684.7482484912814, 687.8624275144991, 691.4433880725963, 3974.761514309093, 4002.6397624213378, 4092.897677558085, 4207.389928460356, 4217.304144816132, 59744.40255597475, 60686.69656651688, 60787.0, 60933.695331523944, 60940.39059609436, 51526.74236628868, 52521.47478525242, 52667.47332526703, 52724.73637631787, 52736.20895686568, 47156.7642161787, 47821.76089119532, 47919.520804792206, 48261.75869120702, 48303.516964829905, 8113.5131892086665, 8120.918790812252, 8233.135520770233, 8327.125651806473, 8334.583270836556, 35580.28839423145, 35881.282374352886, 36384.818075909454, 36396.454053188696, 36429.45355819612, 41858.79070604749, 47029.05941881212, 47220.52779472162, 47563.0, 47742.761286193345, 10076.294659373774, 11091.279066860629, 11108.500117494894, 11216.439178041228, 11564.595239166589, 12412.255264684149, 12852.421641026363, 12854.293013883953, 13115.213087214797, 13168.868311316764, 11871.347075910562, 12249.571265005681, 12534.561290354794, 12618.936905315415, 12627.810582841448, 11545.942270288595, 11869.228500147463, 11894.286342819458, 12036.699082523008, 12277.263364198177, 11414.48634811419, 11735.882641173821, 11769.823452648388, 11903.464344104363, 12180.512779489076, 9526.904730952601, 9624.470654114091, 9708.75728106803, 9921.751956201153, 9946.104850563484, 8696.91303086961, 8706.825863482822, 8903.421277616933, 9444.622215111593, 10057.0], "unit": "score", "name": "yui.html", "value": 6218.974607350583}], "name": "dromaeo_css", "value": 6791.397711816578}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 108.0, 112.0, 110.0, 100.0, 109.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [154.0, 128.0, 152.0, 171.0, 129.0, 153.0, 151.0, 127.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 160.0, 163.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 101.0, 91.0, 73.0, 73.0, 76.0, 112.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 82.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 134.0, 96.0, 96.0, 96.0, 138.0, 96.0, 96.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 57.0, 55.0, 56.0, 56.0, 64.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 121.0, 121.0, 131.0, 126.0, 116.0, 124.0, 114.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.2}, {"lowerIsBetter": true, "replicates": [142.0, 136.0, 143.0, 140.0, 140.0, 130.0, 139.0, 138.0, 142.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 64.0, 67.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1487.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [188.89308651303364], "unit": "score", "name": "DeltaBlue", "value": 350.02869200000004}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1118.5682326621925], "unit": "score", "name": "RayTrace", "value": 661.550166}, {"lowerIsBetter": false, "replicates": [783.868441660141], "unit": "score", "name": "Earley", "value": 850.2230279720281}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [42291.666666666664], "unit": "score", "name": "RegExp", "value": 21.540532019704436}, {"lowerIsBetter": false, "replicates": [585.805700988947], "unit": "score", "name": "Splay", "value": 139.10926415094346}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20072.22427290659}]} 20:06:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20072.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1487.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6791.40"}}} 20:06:33 INFO - Return code: 0 20:06:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:06:33 INFO - # TBPL SUCCESS # 20:06:33 INFO - Running post-action listener: _resource_record_post_action 20:06:33 INFO - Running post-run listener: _resource_record_post_run 20:06:34 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 12288; Write bytes: 541773824; Read time: 216; Write time: 368992 20:06:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237047808; Read time: 172; Write time: 192444 20:06:34 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 304726016; Read time: 44; Write time: 176548 20:06:34 INFO - Running post-run listener: _upload_blobber_files 20:06:34 INFO - Blob upload gear active. 20:06:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:06:34 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:06:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:06:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:06:34 INFO - (blobuploader) - INFO - Open directory for files ... 20:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:35 INFO - (blobuploader) - INFO - Done attempting. 20:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:36 INFO - (blobuploader) - INFO - Done attempting. 20:06:36 INFO - (blobuploader) - INFO - Iteration through files over. 20:06:36 INFO - Return code: 0 20:06:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:06:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:06:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2329340d959f6f52ca37377df80668010139209ee9657208e86a77496e9e9e00a7f42d248d204fd88d3b1298832ad15a777b2254ce39ff6d1a28d7741448a738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79e9c4da90a1c19c01317231068f7f7152f22db5178018b368ce9313d93a3a38c7e2aa4f249d59aae9c0119b9a661cd250124efb108d4f2c184bc6434a4d459b"} 20:06:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:06:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:06:36 INFO - Contents: 20:06:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2329340d959f6f52ca37377df80668010139209ee9657208e86a77496e9e9e00a7f42d248d204fd88d3b1298832ad15a777b2254ce39ff6d1a28d7741448a738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79e9c4da90a1c19c01317231068f7f7152f22db5178018b368ce9313d93a3a38c7e2aa4f249d59aae9c0119b9a661cd250124efb108d4f2c184bc6434a4d459b"} 20:06:36 INFO - Running post-run listener: copy_logs_to_upload_dir 20:06:36 INFO - Copying logs to upload dir... 20:06:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:06:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.978325 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-01-15 20:06:35.532397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 20:06:35.536140) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2329340d959f6f52ca37377df80668010139209ee9657208e86a77496e9e9e00a7f42d248d204fd88d3b1298832ad15a777b2254ce39ff6d1a28d7741448a738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79e9c4da90a1c19c01317231068f7f7152f22db5178018b368ce9313d93a3a38c7e2aa4f249d59aae9c0119b9a661cd250124efb108d4f2c184bc6434a4d459b"} build_url:https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/HJsmZ_J-Sy-ugsZjEQIcJA/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/Fx-Team/sha512/2329340d959f6f52ca37377df80668010139209ee9657208e86a77496e9e9e00a7f42d248d204fd88d3b1298832ad15a777b2254ce39ff6d1a28d7741448a738", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79e9c4da90a1c19c01317231068f7f7152f22db5178018b368ce9313d93a3a38c7e2aa4f249d59aae9c0119b9a661cd250124efb108d4f2c184bc6434a4d459b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 20:06:35.560999) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 20:06:35.561324) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1452911313.251154-2037913914 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 20:06:35.645922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 20:06:35.646276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 20:06:35.646625) ========= ========= Total master_lag: 0.27 =========