builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1453120177.96 results: success (0) buildid: 20160118013002 builduid: afc4ab1878d944ddbb86e016b4fe1ffd revision: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:37.963552) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:37.963994) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:37.964319) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006406 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:37.988811) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:37.989152) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.018522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.018857) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027991 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.068441) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.068735) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.069142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.069463) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-18 04:29:38-- 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% 32.3M=0s 2016-01-18 04:29:38 (32.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.266824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.267135) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:38.321992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-18 04:29:38.322368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8cb42e7a16b42162c9930f37b9e1f820c2eb126b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8cb42e7a16b42162c9930f37b9e1f820c2eb126b --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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-18 04:29:38,984 truncating revision to first 12 chars 2016-01-18 04:29:38,984 Setting DEBUG logging. 2016-01-18 04:29:38,984 attempt 1/10 2016-01-18 04:29:38,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8cb42e7a16b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-18 04:29:40,095 unpacking tar archive at: mozilla-central-8cb42e7a16b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.429627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-18 04:29:39.769652) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.770458) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004697 script_repo_revision: '%(revision)s' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.831656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.831959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.842022) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.842319) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-18 04:29:39.842758) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-01-18 04:29:39.843072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:29:40 INFO - MultiFileLogger online at 20160118 04:29:40 in /builds/slave/test-pgo 04:29:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:29:40 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:29:40 INFO - {'append_to_log': False, 04:29:40 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:29:40 INFO - 'blob_upload_branch': 'Firefox', 04:29:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:29:40 INFO - 'branch': 'Firefox', 04:29:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:40 INFO - 'config_files': ('talos/linux_config.py',), 04:29:40 INFO - 'default_actions': ('clobber', 04:29:40 INFO - 'read-buildbot-config', 04:29:40 INFO - 'download-and-extract', 04:29:40 INFO - 'populate-webroot', 04:29:40 INFO - 'create-virtualenv', 04:29:40 INFO - 'install', 04:29:40 INFO - 'run-tests'), 04:29:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:40 INFO - 'download_minidump_stackwalk': True, 04:29:40 INFO - 'download_symbols': 'ondemand', 04:29:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:40 INFO - 'installer_path': 'installer.exe', 04:29:40 INFO - 'log_level': 'info', 04:29:40 INFO - 'log_name': 'talos', 04:29:40 INFO - 'log_to_console': True, 04:29:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:29:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:29:40 INFO - 'opt_config_files': (), 04:29:40 INFO - 'pip_index': False, 04:29:40 INFO - 'sps_profile': False, 04:29:40 INFO - 'sps_profile_interval': 0, 04:29:40 INFO - 'suite': 'dromaeojs', 04:29:40 INFO - 'system_bits': '32', 04:29:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:40 INFO - 'title': 'talos-linux64-ix-001', 04:29:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:40 INFO - 'use_talos_json': True, 04:29:40 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:29:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:40 INFO - 'work_dir': 'build'} 04:29:40 INFO - ##### 04:29:40 INFO - ##### Running clobber step. 04:29:40 INFO - ##### 04:29:40 INFO - Running pre-action listener: _resource_record_pre_action 04:29:40 INFO - Running main action method: clobber 04:29:40 INFO - rmtree: /builds/slave/test-pgo/build 04:29:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:29:41 INFO - Running post-action listener: _resource_record_post_action 04:29:41 INFO - ##### 04:29:41 INFO - ##### Running read-buildbot-config step. 04:29:41 INFO - ##### 04:29:41 INFO - Running pre-action listener: _resource_record_pre_action 04:29:41 INFO - Running main action method: read_buildbot_config 04:29:41 INFO - Using buildbot properties: 04:29:41 INFO - { 04:29:41 INFO - "project": "", 04:29:41 INFO - "product": "firefox", 04:29:41 INFO - "script_repo_revision": "production", 04:29:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:29:41 INFO - "repository": "", 04:29:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:29:41 INFO - "buildid": "20160118013002", 04:29:41 INFO - "pgo_build": "True", 04:29:41 INFO - "basedir": "/builds/slave/test-pgo", 04:29:41 INFO - "buildnumber": 647, 04:29:41 INFO - "slavename": "talos-linux64-ix-001", 04:29:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:29:41 INFO - "platform": "ubuntu64_hw", 04:29:41 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:29:41 INFO - "branch": "mozilla-central", 04:29:41 INFO - "repo_path": "mozilla-central", 04:29:41 INFO - "revision": "8cb42e7a16b42162c9930f37b9e1f820c2eb126b", 04:29:41 INFO - "stage_platform": "linux64-pgo", 04:29:41 INFO - "builduid": "afc4ab1878d944ddbb86e016b4fe1ffd", 04:29:41 INFO - "slavebuilddir": "test" 04:29:41 INFO - } 04:29:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:29:41 INFO - Running post-action listener: _resource_record_post_action 04:29:41 INFO - ##### 04:29:41 INFO - ##### Running download-and-extract step. 04:29:41 INFO - ##### 04:29:41 INFO - Running pre-action listener: _resource_record_pre_action 04:29:41 INFO - Running main action method: download_and_extract 04:29:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:41 INFO - https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:29:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/test_packages.json 04:29:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/test_packages.json 04:29:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:29:43 INFO - Downloaded 1448 bytes. 04:29:43 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:29:43 INFO - Using the following test package requirements: 04:29:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:29:43 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:29:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'jsshell-linux-x86_64.zip'], 04:29:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:29:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:29:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:29:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:29:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:29:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:29:43 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')]} 04:29:43 INFO - https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:29:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:29:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:29:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:29:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:29:45 INFO - Downloaded 22484146 bytes. 04:29:45 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'] 04:29:45 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 04:29:47 INFO - Return code: 0 04:29:47 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 04:29: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')]} 04:29:47 INFO - https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:29:58 INFO - Downloaded 22484146 bytes. 04:29:58 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'] 04:29:58 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 04:29:59 INFO - Return code: 0 04:29: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')]} 04:29:59 INFO - https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:29:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:30:06 INFO - Downloaded 11132144 bytes. 04:30:06 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'] 04:30:06 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 04:30:06 INFO - Return code: 0 04:30:06 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')]} 04:30:06 INFO - https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JfIALUL7TVqp2hl-8TGVYw/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 04:30:41 INFO - Downloaded 55946376 bytes. 04:30:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - mkdir: /builds/slave/test-pgo/properties 04:30:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:30:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:30:41 INFO - Contents: 04:30:41 INFO - build_url:https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:30:41 INFO - Running post-action listener: _resource_record_post_action 04:30:41 INFO - Running post-action listener: set_extra_try_arguments 04:30:41 INFO - ##### 04:30:41 INFO - ##### Running populate-webroot step. 04:30:41 INFO - ##### 04:30:41 INFO - Running pre-action listener: _resource_record_pre_action 04:30:41 INFO - Running main action method: populate_webroot 04:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:41 INFO - '--tppagecycles', 04:30:41 INFO - '7'], 04:30:41 INFO - 'tests': ['tsvgm']}}, 04:30:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:30:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:30:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['damp', 'tps']}, 04:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['damp', 'tps']}, 04:30:41 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:41 INFO - 'other': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'other_l64': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'other_nol64': {'tests': ['a11yr', 04:30:41 INFO - 'ts_paint', 04:30:41 INFO - 'tpaint', 04:30:41 INFO - 'sessionrestore', 04:30:41 INFO - 'sessionrestore_no_auto_restore']}, 04:30:41 INFO - 'svgr': {'tests': ['tsvgx', 04:30:41 INFO - 'tsvgr_opacity', 04:30:41 INFO - 'tart', 04:30:41 INFO - 'tscrollx', 04:30:41 INFO - 'cart']}, 04:30:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['tsvgx', 04:30:41 INFO - 'tsvgr_opacity', 04:30:41 INFO - 'tart', 04:30:41 INFO - 'tscrollx', 04:30:41 INFO - 'cart']}, 04:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'tests': ['tp5o']}, 04:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--e10s'], 04:30:41 INFO - 'tests': ['tp5o']}, 04:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--xperf_path', 04:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:41 INFO - 'tests': ['tp5n']}, 04:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:30:41 INFO - 'talos_options': ['--e10s', 04:30:41 INFO - '--xperf_path', 04:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:41 INFO - 'tests': ['tp5n']}}, 04:30:41 INFO - 'talos.zip': {'path': '', 04:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:41 INFO - Running post-action listener: _resource_record_post_action 04:30:41 INFO - ##### 04:30:41 INFO - ##### Running create-virtualenv step. 04:30:41 INFO - ##### 04:30:41 INFO - Running pre-action listener: _resource_record_pre_action 04:30:41 INFO - Running main action method: create_virtualenv 04:30:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:30: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 04:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:41 INFO - Using real prefix '/usr' 04:30:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:43 INFO - Installing pip.................done. 04:30:43 INFO - Return code: 0 04:30:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:30:43 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')]} 04:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 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')]} 04:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:43 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 04:30:43 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 04:30:43 INFO - Using env: {'DISPLAY': ':0', 04:30:43 INFO - 'HOME': '/home/cltbld', 04:30:43 INFO - 'LANG': 'en_US.UTF-8', 04:30:43 INFO - 'LANGUAGE': 'en_US:en', 04:30:43 INFO - 'LOGNAME': 'cltbld', 04:30:43 INFO - 'MAIL': '/var/mail/cltbld', 04:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:43 INFO - 'MOZ_NO_REMOTE': '1', 04:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:43 INFO - 'NO_EM_RESTART': '1', 04:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:43 INFO - 'SHELL': '/bin/bash', 04:30:43 INFO - 'SHLVL': '1', 04:30:43 INFO - 'TERM': 'linux', 04:30:43 INFO - 'TMOUT': '86400', 04:30:43 INFO - 'USER': 'cltbld', 04:30:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:43 INFO - '_': '/tools/buildbot/bin/python'} 04:30:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:43 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 04:30:43 INFO - Cleaning up... 04:30:43 INFO - Return code: 0 04:30:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:30:43 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')]} 04:30:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 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')]} 04:30:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:43 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:43 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 04:30:43 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 04:30:43 INFO - Using env: {'DISPLAY': ':0', 04:30:43 INFO - 'HOME': '/home/cltbld', 04:30:43 INFO - 'LANG': 'en_US.UTF-8', 04:30:43 INFO - 'LANGUAGE': 'en_US:en', 04:30:43 INFO - 'LOGNAME': 'cltbld', 04:30:43 INFO - 'MAIL': '/var/mail/cltbld', 04:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:43 INFO - 'MOZ_NO_REMOTE': '1', 04:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:43 INFO - 'NO_EM_RESTART': '1', 04:30:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:43 INFO - 'SHELL': '/bin/bash', 04:30:43 INFO - 'SHLVL': '1', 04:30:43 INFO - 'TERM': 'linux', 04:30:43 INFO - 'TMOUT': '86400', 04:30:43 INFO - 'USER': 'cltbld', 04:30:43 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:43 INFO - '_': '/tools/buildbot/bin/python'} 04:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:44 INFO - Downloading/unpacking psutil>=0.7.1 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:30:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:30:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:45 INFO - Installing collected packages: psutil 04:30:45 INFO - Running setup.py install for psutil 04:30:46 INFO - building 'psutil._psutil_linux' extension 04:30: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 04:30: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 04:30:46 INFO - building 'psutil._psutil_posix' extension 04:30: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 04:30: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 04:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:46 INFO - Successfully installed psutil 04:30:46 INFO - Cleaning up... 04:30:46 INFO - Return code: 0 04:30:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:30:46 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')]} 04:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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')]} 04:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:46 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:46 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 04:30:46 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 04:30:46 INFO - Using env: {'DISPLAY': ':0', 04:30:46 INFO - 'HOME': '/home/cltbld', 04:30:46 INFO - 'LANG': 'en_US.UTF-8', 04:30:46 INFO - 'LANGUAGE': 'en_US:en', 04:30:46 INFO - 'LOGNAME': 'cltbld', 04:30:46 INFO - 'MAIL': '/var/mail/cltbld', 04:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:46 INFO - 'MOZ_NO_REMOTE': '1', 04:30:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:46 INFO - 'NO_EM_RESTART': '1', 04:30:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:46 INFO - 'SHELL': '/bin/bash', 04:30:46 INFO - 'SHLVL': '1', 04:30:46 INFO - 'TERM': 'linux', 04:30:46 INFO - 'TMOUT': '86400', 04:30:46 INFO - 'USER': 'cltbld', 04:30:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:46 INFO - '_': '/tools/buildbot/bin/python'} 04:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:46 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 04:30:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:30:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30: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) 04:30:48 INFO - Installing collected packages: mozsystemmonitor 04:30:48 INFO - Running setup.py install for mozsystemmonitor 04:30:48 INFO - Successfully installed mozsystemmonitor 04:30:48 INFO - Cleaning up... 04:30:48 INFO - Return code: 0 04:30:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:30:48 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')]} 04:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 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')]} 04:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:48 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:48 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 04:30:48 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 04:30:48 INFO - Using env: {'DISPLAY': ':0', 04:30:48 INFO - 'HOME': '/home/cltbld', 04:30:48 INFO - 'LANG': 'en_US.UTF-8', 04:30:48 INFO - 'LANGUAGE': 'en_US:en', 04:30:48 INFO - 'LOGNAME': 'cltbld', 04:30:48 INFO - 'MAIL': '/var/mail/cltbld', 04:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:48 INFO - 'MOZ_NO_REMOTE': '1', 04:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:48 INFO - 'NO_EM_RESTART': '1', 04:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:48 INFO - 'SHELL': '/bin/bash', 04:30:48 INFO - 'SHLVL': '1', 04:30:48 INFO - 'TERM': 'linux', 04:30:48 INFO - 'TMOUT': '86400', 04:30:48 INFO - 'USER': 'cltbld', 04:30:48 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:48 INFO - '_': '/tools/buildbot/bin/python'} 04:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:48 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 04:30:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:30:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:30:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:51 INFO - Downloading docopt-0.6.1.tar.gz 04:30:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:30:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:51 INFO - Running setup.py install for blobuploader 04:30:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:30:51 INFO - Running setup.py install for requests 04:30:51 INFO - Running setup.py install for docopt 04:30:51 INFO - Successfully installed blobuploader requests docopt 04:30:51 INFO - Cleaning up... 04:30:51 INFO - Return code: 0 04:30:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:30:51 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')]} 04:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:51 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')]} 04:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:51 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:51 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 04:30:51 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 04:30:51 INFO - Using env: {'DISPLAY': ':0', 04:30:51 INFO - 'HOME': '/home/cltbld', 04:30:51 INFO - 'LANG': 'en_US.UTF-8', 04:30:51 INFO - 'LANGUAGE': 'en_US:en', 04:30:51 INFO - 'LOGNAME': 'cltbld', 04:30:51 INFO - 'MAIL': '/var/mail/cltbld', 04:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:51 INFO - 'MOZ_NO_REMOTE': '1', 04:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:51 INFO - 'NO_EM_RESTART': '1', 04:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:51 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:51 INFO - 'SHELL': '/bin/bash', 04:30:51 INFO - 'SHLVL': '1', 04:30:51 INFO - 'TERM': 'linux', 04:30:51 INFO - 'TMOUT': '86400', 04:30:51 INFO - 'USER': 'cltbld', 04:30:51 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:51 INFO - '_': '/tools/buildbot/bin/python'} 04:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:30:52 INFO - Running setup.py (path:/tmp/pip-tp6QPh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:30:52 INFO - Running setup.py (path:/tmp/pip-n4RaSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:30:52 INFO - Running setup.py (path:/tmp/pip-NZPhqH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:30:52 INFO - Running setup.py (path:/tmp/pip-IIpUEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:30:52 INFO - Running setup.py (path:/tmp/pip-LiPk69-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:30:52 INFO - Running setup.py (path:/tmp/pip-iaP5iP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:30:52 INFO - Running setup.py (path:/tmp/pip-S7kYbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:30:52 INFO - Running setup.py (path:/tmp/pip-5G4a9L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:30:52 INFO - Running setup.py (path:/tmp/pip-AiUnTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:30:52 INFO - Running setup.py (path:/tmp/pip-uc2t8k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:30:52 INFO - Running setup.py (path:/tmp/pip-HW4574-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:30:52 INFO - Running setup.py (path:/tmp/pip-WUFUzu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:30:52 INFO - Running setup.py (path:/tmp/pip-Hj_HDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:30:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:30:52 INFO - Running setup.py (path:/tmp/pip-xJIRoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:30:53 INFO - Running setup.py (path:/tmp/pip-MrlmzM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:30:53 INFO - Running setup.py (path:/tmp/pip-bleBi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:30:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:30:53 INFO - Running setup.py (path:/tmp/pip-f0QMJS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:30:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:53 INFO - Running setup.py install for manifestparser 04:30:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:30:53 INFO - Running setup.py install for mozcrash 04:30:53 INFO - Running setup.py install for mozdebug 04:30:53 INFO - Running setup.py install for mozdevice 04:30:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:30:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:30:53 INFO - Running setup.py install for mozfile 04:30:53 INFO - Running setup.py install for mozhttpd 04:30:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:30:53 INFO - Running setup.py install for mozinfo 04:30:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:30:53 INFO - Running setup.py install for mozInstall 04:30:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Running setup.py install for mozleak 04:30:54 INFO - Running setup.py install for mozlog 04:30:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Running setup.py install for moznetwork 04:30:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Running setup.py install for mozprocess 04:30:54 INFO - Running setup.py install for mozprofile 04:30:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Running setup.py install for mozrunner 04:30:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:30:54 INFO - Running setup.py install for mozscreenshot 04:30:54 INFO - Running setup.py install for moztest 04:30:54 INFO - Running setup.py install for mozversion 04:30:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:30:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:55 INFO - Cleaning up... 04:30:55 INFO - Return code: 0 04:30:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:30: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')]} 04:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30: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 04:30: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 04:30:55 INFO - Using env: {'DISPLAY': ':0', 04:30:55 INFO - 'HOME': '/home/cltbld', 04:30:55 INFO - 'LANG': 'en_US.UTF-8', 04:30:55 INFO - 'LANGUAGE': 'en_US:en', 04:30:55 INFO - 'LOGNAME': 'cltbld', 04:30:55 INFO - 'MAIL': '/var/mail/cltbld', 04:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:55 INFO - 'MOZ_NO_REMOTE': '1', 04:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:55 INFO - 'NO_EM_RESTART': '1', 04:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:55 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:55 INFO - 'SHELL': '/bin/bash', 04:30:55 INFO - 'SHLVL': '1', 04:30:55 INFO - 'TERM': 'linux', 04:30:55 INFO - 'TMOUT': '86400', 04:30:55 INFO - 'USER': 'cltbld', 04:30:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:55 INFO - '_': '/tools/buildbot/bin/python'} 04:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:30:55 INFO - Running setup.py (path:/tmp/pip-dz_WpG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:30: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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:30:55 INFO - Running setup.py (path:/tmp/pip-fVUKUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:30: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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:30:55 INFO - Running setup.py (path:/tmp/pip-oevoXH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:30: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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:30:55 INFO - Running setup.py (path:/tmp/pip-jzMF97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:30:55 INFO - Running setup.py (path:/tmp/pip-fkpMgg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:30:55 INFO - Running setup.py (path:/tmp/pip-z7_GXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:30:55 INFO - Running setup.py (path:/tmp/pip-Pgz5st-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:30:55 INFO - Running setup.py (path:/tmp/pip-xHLRTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:30:55 INFO - Running setup.py (path:/tmp/pip-Lo4ijI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:30:55 INFO - Running setup.py (path:/tmp/pip-_Z16RU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:30:55 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)) 04:30:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:30:56 INFO - Running setup.py (path:/tmp/pip-QJ7lRZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:30:56 INFO - Running setup.py (path:/tmp/pip-HDwSCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:30:56 INFO - Running setup.py (path:/tmp/pip-aEdO4t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:30:56 INFO - Running setup.py (path:/tmp/pip-7sp2OK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:30:56 INFO - Running setup.py (path:/tmp/pip-bVKYA2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:30:56 INFO - Running setup.py (path:/tmp/pip-O5XzVE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:30: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)) 04:30:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:30:56 INFO - Running setup.py (path:/tmp/pip-23HzB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:30:56 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)) 04:30:56 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)) 04:30:56 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)) 04:30:56 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)) 04:30:56 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)) 04:30:56 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)) 04:30:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:56 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 04:30:58 INFO - Downloading blessings-1.5.1.tar.gz 04:30: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 04:30:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:58 INFO - Installing collected packages: blessings 04:30:58 INFO - Running setup.py install for blessings 04:30:58 INFO - Successfully installed blessings 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:30:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:30:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:30:58 INFO - Reading from file tmpfile_stdout 04:30:58 INFO - Current package versions: 04:30:58 INFO - argparse == 1.2.1 04:30:58 INFO - blessings == 1.5.1 04:30:58 INFO - blobuploader == 1.2.4 04:30:58 INFO - docopt == 0.6.1 04:30:58 INFO - manifestparser == 1.1 04:30:58 INFO - mozInstall == 1.12 04:30:58 INFO - mozcrash == 0.16 04:30:58 INFO - mozdebug == 0.1 04:30:58 INFO - mozdevice == 0.48 04:30:58 INFO - mozfile == 1.2 04:30:58 INFO - mozhttpd == 0.7 04:30:58 INFO - mozinfo == 0.9 04:30:58 INFO - mozleak == 0.1 04:30:58 INFO - mozlog == 3.1 04:30:58 INFO - moznetwork == 0.27 04:30:58 INFO - mozprocess == 0.22 04:30:58 INFO - mozprofile == 0.28 04:30:58 INFO - mozrunner == 6.11 04:30:58 INFO - mozscreenshot == 0.1 04:30:58 INFO - mozsystemmonitor == 0.0 04:30:58 INFO - moztest == 0.7 04:30:58 INFO - mozversion == 1.4 04:30:58 INFO - psutil == 3.1.1 04:30:58 INFO - requests == 1.2.3 04:30:58 INFO - wsgiref == 0.1.2 04:30:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'DISPLAY': ':0', 04:30:58 INFO - 'HOME': '/home/cltbld', 04:30:58 INFO - 'LANG': 'en_US.UTF-8', 04:30:58 INFO - 'LANGUAGE': 'en_US:en', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MAIL': '/var/mail/cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SHLVL': '1', 04:30:58 INFO - 'TERM': 'linux', 04:30:58 INFO - 'TMOUT': '86400', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - '_': '/tools/buildbot/bin/python'} 04:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 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)) 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'DISPLAY': ':0', 04:30:58 INFO - 'HOME': '/home/cltbld', 04:30:58 INFO - 'LANG': 'en_US.UTF-8', 04:30:58 INFO - 'LANGUAGE': 'en_US:en', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MAIL': '/var/mail/cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SHLVL': '1', 04:30:58 INFO - 'TERM': 'linux', 04:30:58 INFO - 'TMOUT': '86400', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - '_': '/tools/buildbot/bin/python'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Downloading/unpacking jsonschema 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:31:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:00 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 04:31:00 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:31:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:01 INFO - warning: no files found matching '*.txt' 04:31:01 INFO - no previously-included directories found matching 'build' 04:31:01 INFO - no previously-included directories found matching 'dist' 04:31:01 INFO - no previously-included directories found matching '.git*' 04:31:01 INFO - Installing collected packages: jsonschema, functools32 04:31:01 INFO - Running setup.py install for functools32 04:31:01 INFO - warning: no files found matching '*.txt' 04:31:01 INFO - no previously-included directories found matching 'build' 04:31:01 INFO - no previously-included directories found matching 'dist' 04:31:01 INFO - no previously-included directories found matching '.git*' 04:31:01 INFO - Successfully installed jsonschema functools32 04:31:01 INFO - Cleaning up... 04:31:01 INFO - Return code: 0 04:31:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:31: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')]} 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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 0x7f2dd8720f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, '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': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', '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 04:31: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 04:31: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 04:31:01 INFO - Using env: {'DISPLAY': ':0', 04:31:01 INFO - 'HOME': '/home/cltbld', 04:31:01 INFO - 'LANG': 'en_US.UTF-8', 04:31:01 INFO - 'LANGUAGE': 'en_US:en', 04:31:01 INFO - 'LOGNAME': 'cltbld', 04:31:01 INFO - 'MAIL': '/var/mail/cltbld', 04:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:01 INFO - 'MOZ_NO_REMOTE': '1', 04:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:01 INFO - 'NO_EM_RESTART': '1', 04:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:31:01 INFO - 'PWD': '/builds/slave/test-pgo', 04:31:01 INFO - 'SHELL': '/bin/bash', 04:31:01 INFO - 'SHLVL': '1', 04:31:01 INFO - 'TERM': 'linux', 04:31:01 INFO - 'TMOUT': '86400', 04:31:01 INFO - 'USER': 'cltbld', 04:31:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:01 INFO - '_': '/tools/buildbot/bin/python'} 04:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:01 INFO - Downloading/unpacking flake8 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31: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 04:31:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:03 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 04:31:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:03 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 04:31:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:31:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:03 INFO - no previously-included directories found matching 'docs/_build' 04:31:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:03 INFO - Running setup.py install for pep8 04:31:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:03 INFO - no previously-included directories found matching 'docs/_build' 04:31:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:31:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:04 INFO - Cleaning up... 04:31:04 INFO - Return code: 0 04:31:04 INFO - Running post-action listener: _resource_record_post_action 04:31:04 INFO - Running post-action listener: _start_resource_monitoring 04:31:04 INFO - Starting resource monitoring. 04:31:04 INFO - ##### 04:31:04 INFO - ##### Running install step. 04:31:04 INFO - ##### 04:31:04 INFO - Running pre-action listener: _resource_record_pre_action 04:31:04 INFO - Running main action method: install 04:31:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:31:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:31:04 INFO - Reading from file tmpfile_stdout 04:31:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:31:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:31:04 INFO - Reading from file tmpfile_stdout 04:31:04 INFO - Output received: 04:31:04 INFO - Usage: mozinstall [options] installer 04:31:04 INFO - Options: 04:31:04 INFO - -h, --help show this help message and exit 04:31:04 INFO - -d DEST, --destination=DEST 04:31:04 INFO - Directory to install application into. [default: 04:31:04 INFO - "/builds/slave/test-pgo"] 04:31:04 INFO - --app=APP Application being installed. [default: firefox] 04:31:04 INFO - mkdir: /builds/slave/test-pgo/build/application 04:31:04 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'] 04:31:04 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 04:31:20 INFO - Reading from file tmpfile_stdout 04:31:20 INFO - Output received: 04:31:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:31:20 INFO - Running post-action listener: _resource_record_post_action 04:31:20 INFO - ##### 04:31:20 INFO - ##### Running run-tests step. 04:31:20 INFO - ##### 04:31:20 INFO - Running pre-action listener: _resource_record_pre_action 04:31:20 INFO - Running main action method: run_tests 04:31:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:31:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:31:20 INFO - Python 2.7.3 04:31:20 INFO - Return code: 0 04:31:20 INFO - grabbing minidump binary from tooltool 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:20 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 0x1be4840>, '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 0x1b516b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b51b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:31:20 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 04:31:20 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 04:31:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:20 INFO - Return code: 0 04:31:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:31:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:31:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:31:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:31:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:31:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:31:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:31:21 INFO - Return code: 0 04:31:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:31:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 04:31:21 INFO - Using env: {'DISPLAY': ':0', 04:31:21 INFO - 'HOME': '/home/cltbld', 04:31:21 INFO - 'LANG': 'en_US.UTF-8', 04:31:21 INFO - 'LANGUAGE': 'en_US:en', 04:31:21 INFO - 'LOGNAME': 'cltbld', 04:31:21 INFO - 'MAIL': '/var/mail/cltbld', 04:31:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:31:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:21 INFO - 'MOZ_NO_REMOTE': '1', 04:31:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:21 INFO - 'NO_EM_RESTART': '1', 04:31:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:31:21 INFO - 'PWD': '/builds/slave/test-pgo', 04:31:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:31:21 INFO - 'SHELL': '/bin/bash', 04:31:21 INFO - 'SHLVL': '1', 04:31:21 INFO - 'TERM': 'linux', 04:31:21 INFO - 'TMOUT': '86400', 04:31:21 INFO - 'USER': 'cltbld', 04:31:21 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400', 04:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:21 INFO - '_': '/tools/buildbot/bin/python'} 04:31:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 04:31:21 INFO - mozversion application_buildid: 20160118013002 04:31:21 INFO - mozversion application_changeset: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b 04:31:21 INFO - mozversion application_display_name: Nightly 04:31:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:21 INFO - mozversion application_name: Firefox 04:31:21 INFO - mozversion application_remotingname: firefox 04:31:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:21 INFO - mozversion application_vendor: Mozilla 04:31:21 INFO - mozversion application_version: 46.0a1 04:31:21 INFO - mozversion platform_buildid: 20160118013002 04:31:21 INFO - mozversion platform_changeset: 8cb42e7a16b42162c9930f37b9e1f820c2eb126b 04:31:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:21 INFO - mozversion platform_version: 46.0a1 04:31:21 INFO - using testdate: 1453120281 04:31:21 INFO - actual date: 1453120281 04:31:21 INFO - starting webserver on 'localhost:57542' 04:31:21 INFO - SUITE-START | Running 3 tests 04:31:21 INFO - TEST-START | dromaeo_css 04:31:21 INFO - operating with platform_type : linux_ 04:31:21 INFO - Initialising browser for dromaeo_css test... 04:31:21 INFO - TEST-INFO | started process 17260 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOjj229/profile http://localhost:57542/getInfo.html) 04:31:25 INFO - PROCESS | 17260 | __metrics Screen width/height:1600/1200 04:31:25 INFO - PROCESS | 17260 | colorDepth:24 04:31:25 INFO - PROCESS | 17260 | Browser inner width/height: 1024/697 04:31:25 INFO - PROCESS | 17260 | __metrics 04:31:25 INFO - PROCESS | 17260 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:31:25 INFO - PROCESS | 17260 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:26 INFO - TEST-INFO | 17260: exit 0 04:31:26 INFO - Browser initialized. 04:31:26 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:26 INFO - TEST-INFO | started process 17351 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOjj229/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:38 INFO - PROCESS | 17351 | RSS: Main: 149352448 04:31:38 INFO - PROCESS | 17351 | 04:32:29 INFO - PROCESS | 17351 | 1453120349995 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] 04:34:38 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57542/tests/dromaeo/cssquery-ext.html) 04:34:39 INFO - PROCESS | 17351 | RSS: Main: 247357440 04:34:39 INFO - PROCESS | 17351 | 04:37:41 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-ext.html (next: http://localhost:57542/tests/dromaeo/cssquery-jquery.html) 04:37:42 INFO - PROCESS | 17351 | RSS: Main: 226955264 04:37:42 INFO - PROCESS | 17351 | 04:40:44 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57542/tests/dromaeo/cssquery-mootools.html) 04:40:44 INFO - PROCESS | 17351 | RSS: Main: 225808384 04:40:44 INFO - PROCESS | 17351 | 04:43:46 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57542/tests/dromaeo/cssquery-prototype.html) 04:43:47 INFO - PROCESS | 17351 | RSS: Main: 206774272 04:43:47 INFO - PROCESS | 17351 | 04:46:49 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57542/tests/dromaeo/cssquery-yui.html) 04:46:50 INFO - PROCESS | 17351 | RSS: Main: 209649664 04:46:50 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | Cycle 1(1): loaded http://localhost:57542/tests/dromaeo/cssquery-yui.html (next: http://localhost:57542/tests/dromaeo/cssquery-dojo.html) 04:49:53 INFO - PROCESS | 17351 | RSS: Main: 273813504 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | __start_tp_report 04:49:53 INFO - PROCESS | 17351 | _x_x_mozilla_page_load 04:49:53 INFO - PROCESS | 17351 | _x_x_mozilla_page_load_details 04:49:53 INFO - PROCESS | 17351 | |i|pagename|runs| 04:49:53 INFO - PROCESS | 17351 | |0;dojo.html;3091.2117410060437;3091.7526597872175;3149.2441813964642;3159.210197450637;3175.618925728913;5020.874478138048;5038.34501514803;5062.772175252108;5104.846854594359;5110.667806592569;5069;5105.004524117799;5106.5659418949435;5108.361454818148;5117.3091632629585;4482.260427029552;4644.326572646964;4646.976765116178;4688.062387522509;4714.882127946795;4597.701149425294;4619.815207391717;4625.074985002996;4681.016986432854;4767.928481072787;4575.565321294472;4637.884052898671;4651.8837029074375;4663.953360466386;4683.929741053887;4641.559051890065;4645.488996210414;4655.185342565038;4678.298255261704;4680.695754775928;4589.678722489427;4640.535946405366;4652.13935421948;4663.160631086403;4684.765761711901;4918.704877707313;4980.377452818398;4994.475580064077;5000.74996250186;5049.84850454487;5509.862253443656;5511.669299842022;5518.724063796834;5525.364583072917;5572.275604171432;5397.892042159174;5492.258545096401;5493.505584497414;5557.472040156219;5559;5122.718250496221;5129.333186685782;5141.100307446182;5144.382674079097;5182.663126896778;5579.995600791896;5580.1629755537;5581.469760372758;5594.300712410949;5597.80407685729;5313.07021271276;5373.247745315659;5386.461353864583;5390.4879036491475;5480.095784195563;5418.458154184629;5471.179323101566;5471.452854714496;5476.726163691799;5481.561475081984;5449.6730196188355;5485.040117979417;5485.50630443262;5491.780328786884;5541.224228607998;5390.245365648812;5444.210589464585;5458.563314934875;5461.535769459561;5537.640053396516;4281.785910704452;4290.957090429119;4294.312909934395;4298.699091063658;4340.82636694535;3762.981185094057;3827.61723827615;3835.7890316032885;3859.0352411897024;3874.1670540833293;5075.87310317245;5132.461091585405;5137.12668846297;5155.536001759785;5192.221166824931;5442.8095016675015;5471.935715998974;5501.532369748536;5504.697241651747;5504.889902201933;4973.303737476756;5036.79852805891;5142.5628821549835;5147.3308469898675;5155.871103222375;4688;4708.717476951394;4734.147853386424;4739.075880203327;4772.522747725269;5653.434656534314;5678.318601767732;5681.460261275172;5683.318001839723;5734.369219385864;5418.918716219181;5441.047816632153;5447.482489163682;5450.5367043801725;5493.560515158698;5692.544596432358;5697.686627235376;5709.628874123168;5710.3433105193435;5719.456651618089;5350.411454739898;5362.222477740628;5391.892162156813;5394.757235924314;5398.352197736297;5407.891842163056;5441.428649991693;5490.066688662857;5508.752106155152;5535.944640553543;5379.273798037371;5383.784648614168;5383.919241211307;5388.811391601275;5389.649672771257;5368.516833485005;5376.247325374529;5380.838574842761;5382.946170538245;5421.728913554385;5168.198929165986;5288.365396152486;5295.311609490742;5313.203019547099;5377.569794416516;5291.920621190762;5319.734013299397;5321.840344789663;5344;5379.865503362447;5222.55608273301;5227.581793456438;5227.973860130675;5246.3704355477585;5265.89468210626 04:49:53 INFO - PROCESS | 17351 | |1;ext.html;516.1328967334875;532.6298222735201;538.0610834094506;559.829955393228;563.2677519225008;30558.083257502283;31145.84427077864;35652.2869542609;35694.82152589237;35757.64242357576;38019.239615207676;38431.615683843156;38552.421713674245;38609.22781544367;38712.22575548488;8266.380021498397;8433.536155511445;8449.788755281106;8455.492670439793;8459.957700211491;8228.958855205716;8315.708950186745;8329.208725171098;8368.079511253758;8379.790505237388;8539.829203415928;8565.8007878897;8626.78433039176;8635.784105397384;8641.740747777545;8463.153684631548;8551.187637174458;8554.743357699279;8560.61477233526;8571.828563428697;8340.416170868042;8508.106648801848;8509.106543812934;8515.361347898932;8522.318214542822;38613;39012.60987390118;39019.60980390188;39097;39127.60872391296;3223.06531105979;3240.5985995701576;3288.1943923738836;3594.388953877847;3770.8680196193;27841.16476505708;29093.85453072742;29418.264543386373;29512;29520.704792952227;3557.6086630470627;3558.3594952908466;3672.467492213641;3690.538682664667;3711.6473934976134;270279;270666;271043;271337;271793;55762.76948922079;55903.16145257824;56035.15947260794;56128.71935640296;56149.43850561524;56989;57009;57419.712901435225;57514.424855750905;57603.42396575981;14807.629809254855;14998.850011499964;15001.249937503082;15004.399824007136;15006.62483437901;10761.730956725987;10845.132389408986;10853.40306283162;10862.402567858844;10874.782504349869;18011.459656210336;18447.446576602724;18538.258469661334;18539.443816685252;18618.627627447375;7593.6582853771715;7879.803004924923;7913.169117242722;7926.24700653437;8042.195780421911;936.7054730362677;986.9457179855177;1028.8508166315842;1070.882202957674;1080.6055789636725;27962;27973.30066748307;28344.291392715346;28444.288892777433;28457.288567785556;901.8917729872458;904.7738065483629;979.1872745621117;1038.8597539332093;1046.8482070099792;12133.393330333449;12953.935230323788;13505.662358441117;13560.321983900765;13610.93194534021;250083;254121;254665;256555;257119;47233.29150062752;47594.5240547597;47620.28569571459;47670.761646191546;47731.76134119307;1165.6794381544973;1238.646985609097;1274.6877015131352;1295.3264302562616;1298.2016060122955;24759.50480990406;27868.88524458999;28141.155765327072;28384;28467.28831779222;39036.80481597574;39269.21461570695;39437.80281098576;39764;39819.40270895997;286476;291765;301798;306594;306725.73097075865;27726.861365693043;27788.58317125204;27790.583141252493;27844.30389240204;27849.860750696927;35858.8207058963;36805.63194368022;37339.62660373362;37512.249755005294;37564.62435375611;31821.681783181873;31878.68121318757;32070.198245043128;32333.191670208435;32415.67584324221;34390.82804586061;34918.65081349154;35330.29339413249;35364.469532956515;35433.64566354304;33977.772111649356;34287.82856085704;34516.30967380588;34612.48081278833;34853.1286717824;29722.55416168716;30851.537226941164;31297.8435107823;31405.371892562478;31644.367112657157;24100.87949560241;24221.273361799173;24250;24437.266881993568;24503.264902052968 04:49:53 INFO - PROCESS | 17351 | |2;jquery.html;367.57545035484026;368.83402468889005;370.6775105658078;371.8921512761298;373.19390117346535;13852.515161969333;13855.653608659788;15687.764683529756;16476.752848707263;17278.136093195353;10911.236213465061;11189.16081293902;16468.670626587493;16938.745918811226;16955.91522042388;4837.709737415748;4954.851354459372;4955.628327875405;4976.402831660206;4996.65023448357;3776.773393596393;3904.7461914975434;4949.653524253304;4998.22527508235;5314.7608357624;5501.504864562188;5502.312210973629;5502.477264659871;5507.421720719327;5534.557235421156;5356.1697936819855;5626.2685850839125;5628.099504079328;5632.211490391349;5635.380108188096;5222.164453687392;5357.651752636066;5375.623706340558;5390.946090539122;5393.1101368274185;11949.701257468545;12424.254544727346;12450.564230251897;20273.290434834857;20411.183552657876;2082.833373330145;2109.0720083163515;2140.464883779055;2191.6822060801096;2229.944251393712;8971.102889711043;9073.81852362949;9369.953150234272;9451.149396554343;9516.666916657883;1822.9453116406528;1841.4475657302755;1857.322077441724;1873.3349660870467;1945.873518221311;57386.426135738526;58276.125858112166;59047;60046;60291.39708602946;10223.539940702687;10232.795344093225;10234.48827558619;10256.846147307797;10297.433641149808;13201.933990329986;13303.201807891557;13315.467381304834;13324;13337.599872003855;7153.284671532909;7229.2409297024105;7291.671874765649;7321.048263725682;7372.815679608053;6800.761973330909;6878.793636190822;6903.516753827284;6944.618046007417;7069.469789765788;4404.207242696281;4478.149151661174;4488.259437192892;4534.77326133692;4563.110193512233;1712.0918810263295;1772.9024903630425;1836.0250058623199;1913.885166889991;1948.2693989753843;428.3874060094033;431.0516862901629;859.8108416148438;944.9952750236205;952.9904700952902;9784.804303913881;9994.650187243557;10519.26365154432;10527.315724478038;10678.893211067945;464.8814552289145;469.3452633576142;477.79932428380164;478.1584411435828;481.2636665901177;4622.722636641813;6054.757809687651;6240.7503699851495;6262.2172228471445;6355.713992870332;400050;406288;407393;411261;532351;71778;72433.6378318105;72981.6350918242;74498.62750686321;75132;1131.8019346614474;1150.916840518664;1162.918595698293;1171.2211379432752;1173.7359094203907;14922.25388730581;15063.397464101314;15254.237288135771;15340.386384544494;15462.613434663774;33728;34028;34199.31601368009;34230;34378.312433751686;40476.59523404728;42064.36903446512;43117.13765724605;43400.56599433965;44367.33448998203;7099.929000709927;7137;7335.496223274109;7500.512466689648;7523.473356864967;8964.641414343354;10221.080102790487;10901;10947.397893115955;11269.66191014271;3122.157017605279;3128.7966282191583;9253.213476854542;9403.905960940303;9650.227981761582;9690.70927872165;9714.311297712293;9888.110070093726;10122.493875306352;10248.436336001592;8970.820583588422;9079.45523268606;9890.75273118149;10109.342892712244;10224.028717271847;7289;7297.963510182628;7344.265573442826;7451.627418628938;7573.2805383488485;8893.866592000995;9704.95147524286;9805.21558275322;9879.407235565888;9961.452120133463 04:49:53 INFO - PROCESS | 17351 | |3;mootools.html;1317.4927652853648;1478.8373278939314;1482.5181815909825;1660.7508873668949;1826.5707558723707;6665.40011398974;7197.60413177275;7370.410367170627;7374.262573742623;7378.557286562804;7307.269273072703;7466.6266686665585;7467.701291948316;7479.065116860393;7482.2517748225155;2006.2877678424168;2064.8038436348525;2206.161658569741;2304.6082166031815;2332.568474832153;2265.5808675395024;2268.6823844661762;2268.8298377621663;2269.9773002270013;2271.3753717727673;2220;2308.492131731025;2309.2956648222284;2310.0182422470466;2312.1791763923816;2276.4195130241765;2290.4159439342943;2335.8131349492087;2354.482013956927;2354.6703461515403;2275.6927814745127;2310.988445057764;2317.606006978801;2317.9072837086496;2321.292005938188;7056.223815380304;7077.292270772933;7089.291070892921;7096.219415864251;7103.431725462003;4602.286645569942;4694.624430045588;4696.201645720202;4699.812007519695;4701.412323459567;3027.1070034339923;3049.557814116941;3062.525308577174;3071.66211716711;3181.984090079558;1007.0885848307221;1011.5801942193981;1014.8582844300163;1067.8184708599556;1075.2204651627585;10180.847287290697;10212.438315892623;10237.232207584386;10239.641612543599;10248.846267305997;4250.341197114452;4339.284018137035;4349.282368409177;4354;4387.056782791651;8792.340574456814;8799.824003520022;8807.383483156245;8807.69173078952;8813.294936405073;4867.58625516835;4870.683405578697;4876.122297986326;4883.658143929891;4886.755662216946;4408.162449134654;4408.647308215335;4447.599716025573;4452.844150454718;4456.331550267486;3448.620651728308;3517.9120521986642;3610.422332426799;3694.9261014779554;3702.9444558331647;1207.1067410116625;1224.7121926347302;1227.0429065329058;1236.8886800188027;1239.9690007749878;1004.603181743222;1019.5310157327564;1021.9437930913722;1131.852859128308;1309.594025851989;6849.1096157499205;6869.690863911136;6872.518923675295;6893.931060689329;6894.896576551356;1178.2753606531921;1181.7813704464702;1198.328935795957;1220.885615475852;1224.9142560020714;5354;5362.839114826562;5380.623356365017;5398.541124004503;5410.97294513525;8809.515476648847;9141.314401419788;9264.397814142194;9267.953660231791;9283.628654853865;9055.411398259092;9056.637734490678;9079.909200908038;9116.225120864668;9205.217556507638;6986.685599148051;7445.287583855744;7453.068366454193;7470.514416562906;7501.362384197404;6793.6942837573415;6795.1845778506895;6820.454363650797;6834.624095674786;6838.589684618939;8188.959055204686;8291.626876790438;8467.068622451403;8581;8619.439736417113;8396.832063358577;8496.235338819288;8517.659293628185;8521.275691566287;8525.275351595184;6285.182926219562;6426.29310775805;6426.807195784134;6431.871362572816;6432.807015789534;6371.776987805404;6578.7368505261165;6872.209695885037;6910.896336554855;7111.2533184017;6580.5064620152725;6634.83412914681;6713.530052896251;6722.193336799615;6756.425703815231;6462.063000864754;6499.837504062436;6527.869442611216;6611.371919667624;6647.767328143492;6558.475321974135;6563.835904102436;6574.3754343337305;6577.046328282468;6585.176852893388;6245.531585131224;6260.68696565179;6270.905936411049;6275.466585340298;6278.811635650938;6175.62946223228;6298.370162983848;6304.401081897213;6315.179026726496;6319.210098737658 04:49:53 INFO - PROCESS | 17351 | |4;prototype.html;339.25025693217987;342.8851334802841;349.3414912889203;349.7114880223815;353.90642913397596;5827.242458480397;5894.410558944109;5911.172435858973;5937.257842769648;5943.970280148593;5581.609287349887;5728.054870946289;5733.713314334287;5768.913466298009;5815.127730840376;4416.624586910117;4462.933056004163;4496.572825581565;4519.050999290153;4540.069285796404;4516.41286632739;4520.57054579816;4528.773561321937;4540.659450541206;4542.8864278392975;4305.203537345586;4394.450693663292;4496.303073023671;4505.053938672866;4515.119551687422;4393.1213757248515;4429.623482004034;4456.331550267453;4470.597646211857;4480.775961201944;3982.362821948503;3986.3422535281934;3986.4452863383303;3995.9400608990886;3996.7002474814212;5595.860103497404;5601.80393686219;5603.2435621191025;5617.494425501724;5625.5218306444;5084.9745751271;5197.48025197481;5238.188080847474;5245.895082098375;5246.449122842123;6147.2008638877105;6150.815475535696;6153.476954458876;6156.7537298508005;6158.538109641795;4300.80646370914;4303.182395344875;4308.504521979981;4310.331898555697;4351.064521127941;6359.491240700779;6407.8398040048905;6416.101745755598;6426.325235850215;6432.195975503062;4322.092360604245;4404.185225733249;4410.095930334273;4413.624841888475;4432.734035957853;4458.910821783546;4472.910541789146;4479.731216127043;4479.865604031885;4481.887952801206;5158.845234642967;5162.870928226749;5163.070647283525;5163.922541161885;5167.457416971164;6182.783602573978;6190.380961903864;6191.628502289877;6193.876122477525;6195.690215489298;1530.7856900034003;1580.936762529509;1582.7151112799806;1584.4216860845938;1589.36425429829;1050.2700623066896;1073.2540884085643;1076.3057827701246;1086.255914698434;1088.0642647323295;5813.82558523245;5821.621594596338;5831.067029275296;5834.066549352084;5836.095405212199;6288.685565721696;6289.96855015722;6293.590916590407;6296.307406185316;6299.905501417483;5697.601167918206;5826.65040097587;5831.067029275296;5834.212381328552;5877.735501902424;3354.9496757548654;3411.5053317268857;3423.400904841643;3433.9828300858835;3445.638207988125;6632.2704502504685;6662.800115996528;6670.83322916931;6672.766453174116;6683.866322673519;6420.422162005442;6487.870242595121;6531.5427920046095;6534.444572211415;6539.5422320438065;6662.966685166543;6666.300038495985;6676.599404035774;6681.5656982296;6692.5984440932725;6352.809415717536;6376.74493020274;6378.585391949508;6381.329960354282;6389.201349831271;6172.197614310111;6312.495000400048;6316.873662526816;6318.526110541636;6319.399657032574;6716.126903502513;6721.361470660279;6722.630255336004;6726.8990965136545;6729.663516824237;4462.955370446384;4499.865004049753;4501.864944051684;4503.392042074278;4509.90980180388;6462.870742585216;6469.967650161907;6474.643894585843;6475.579087359495;6491.026346048131;6134.754609815557;6305.022721478178;6305.211848518935;6307.779227727191;6311.147995020613;6272.717727702173;6274.529410294337;6280.183576135256;6281;6281.874362512815;6006.129111278928;6179.5056395489155;6186.938130618636;6193.969030154821;6196.1015652731;6299.937000629935;6300.9684951574945;6310.400511951358;6320.735852829361;6325.399087086719;6167.629942203482;6169.413905678954;6174.413430724074;6175.382461753788;6186.907196391968 04:49:53 INFO - PROCESS | 17351 | |5;yui.html;819.135811718637;824.9298809601183;831.9958400207998;851.6295411495998;888.409207876762;12576.056795740322;12716.554920577782;12731.745365092704;12734.745305093904;12778.61664150077;11687.5909343173;11958.402079896014;11990.760184796321;12002;12021.879781202208;653.9509536784748;807.8990126234221;822.1203312455675;823.4853216739538;824.1675907333606;798.9720359787409;806.568485860065;806.9636866341028;807.0114110214998;816.3550794872074;697.3235961117708;704.2957042957042;847.9576021198947;853.1212850763692;854.4830377621543;837.7947402886301;844.6579135450153;847.5677404523738;849.0405841399179;849.9447535910177;624.709510077816;630.4326106504183;631.0030152359261;631.3844002097964;631.8483563944666;12374.195677280948;12397.938010309981;12399.194052386567;12401.069919755964;12409.62771116868;12252.754944901051;12358;12668.619941401772;12873.420696068699;13246.139000965002;10288.331258468175;10373.636922707668;10431.217658675554;10944.671659850217;11026;3576.624454432273;3639.47227651989;3656.140806910374;3737.495438115847;3738.2336620992905;48551.75724121392;49981.750091249676;50045.497725113964;50067.74966125146;50431.747841260556;9552.61789528425;9596.472194029395;9726.805463890683;9746.171575416169;9965.80068398628;16348.34606615722;16349.264283107288;16417.753733694004;16443.58891027734;16444.506664800076;7153.678084486107;7268.854622907618;7355.742549010759;7405.7778266652085;7506.43701722373;4183.163367326547;4234.724742891703;4243.384709217146;4252.617264446215;4267.850625228102;3059.128148477673;3075.8769649214228;3076.1540576341235;3085.2132706160232;3089.2431354318337;541.4801790281374;553.2006250967314;556.3101753825308;559.1500918603699;564.9491545760901;545.0624925128773;564.3876394112352;575.6833741442274;637.6715991264502;672.2057740498907;8359.916400836035;9205.585748641193;9232.630694772133;9707.271954603433;9757.219422446187;503.4965034965035;611.2970084402972;693.5110746923407;698.8392669686001;751.4138971602159;3905.433712111728;3975.602439756059;4194.2450358935685;4206.26390381682;4231.217224813419;54112.45887541074;54136;54407;54548;54724;48725.51274487281;49023;49216.26175607297;50763.23855142176;51298;45710.42895710402;46320;46389.7680511602;47571;48067.75966120147;8654.264387526879;8725.869111963199;8755.25580325654;8785.648574057223;8915.153060459246;33518;33839.49240761341;34270.31459370749;34545.13637159091;34854.82572587121;40252.79873600613;40473.39289910595;42658.78670606751;43033.56966430421;43563.78218108889;11331.886681133083;11355.943220283845;11422.543098276308;11788.29270243788;11807.468663909973;12185.329806860353;12642.747145057232;12793.29636869981;13027.739445210853;13029.348532573524;11415.60045398407;11676.766464670829;11718.648440546796;11756.35340056271;12058.698532536757;10785.676429707122;11026.944865275944;11239.157063220127;11405.657830265105;11524.654260372203;10891.618793342195;11213.439328033728;11356.54573817038;11615.128865334964;11618.419079046183;9515.714528564155;9717.12545870875;9811.362261452983;9816.460094694861;9931.57806141138;8817.691380801642;9112.271018318652;9281.953590232006;9699.5150242489;9765.462899540593 04:49:53 INFO - PROCESS | 17351 | __end_tp_report 04:49:53 INFO - PROCESS | 17351 | __start_cc_report 04:49:53 INFO - PROCESS | 17351 | _x_x_mozilla_cycle_collect,823 04:49:53 INFO - PROCESS | 17351 | __end_cc_report 04:49:53 INFO - PROCESS | 17351 | __startTimestamp1453121393336__endTimestamp 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | ------- Summary: start ------- 04:49:53 INFO - PROCESS | 17351 | Number of tests: 6 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#0] dojo.html Cycles:165 Average:5090.86 Median:5291.92 stddev:548.94 (10.4%) stddev-sans-first:527.73 04:49:53 INFO - PROCESS | 17351 | Values: 3091.2 3091.8 3149.2 3159.2 3175.6 5020.9 5038.3 5062.8 5104.8 5110.7 5069.0 5105.0 5106.6 5108.4 5117.3 4482.3 4644.3 4647.0 4688.1 4714.9 4597.7 4619.8 4625.1 4681.0 4767.9 4575.6 4637.9 4651.9 4664.0 4683.9 4641.6 4645.5 4655.2 4678.3 4680.7 4589.7 4640.5 4652.1 4663.2 4684.8 4918.7 4980.4 4994.5 5000.7 5049.8 5509.9 5511.7 5518.7 5525.4 5572.3 5397.9 5492.3 5493.5 5557.5 5559.0 5122.7 5129.3 5141.1 5144.4 5182.7 5580.0 5580.2 5581.5 5594.3 5597.8 5313.1 5373.2 5386.5 5390.5 5480.1 5418.5 5471.2 5471.5 5476.7 5481.6 5449.7 5485.0 5485.5 5491.8 5541.2 5390.2 5444.2 5458.6 5461.5 5537.6 4281.8 4291.0 4294.3 4298.7 4340.8 3763.0 3827.6 3835.8 3859.0 3874.2 5075.9 5132.5 5137.1 5155.5 5192.2 5442.8 5471.9 5501.5 5504.7 5504.9 4973.3 5036.8 5142.6 5147.3 5155.9 4688.0 4708.7 4734.1 4739.1 4772.5 5653.4 5678.3 5681.5 5683.3 5734.4 5418.9 5441.0 5447.5 5450.5 5493.6 5692.5 5697.7 5709.6 5710.3 5719.5 5350.4 5362.2 5391.9 5394.8 5398.4 5407.9 5441.4 5490.1 5508.8 5535.9 5379.3 5383.8 5383.9 5388.8 5389.6 5368.5 5376.2 5380.8 5382.9 5421.7 5168.2 5288.4 5295.3 5313.2 5377.6 5291.9 5319.7 5321.8 5344.0 5379.9 5222.6 5227.6 5228.0 5246.4 5265.9 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#1] ext.html Cycles:180 Average:43355.41 Median:34885.89 stddev:71900.07 (206.1%) stddev-sans-first:72029.82 04:49:53 INFO - PROCESS | 17351 | Values: 516.1 532.6 538.1 559.8 563.3 30558.1 31145.8 35652.3 35694.8 35757.6 38019.2 38431.6 38552.4 38609.2 38712.2 8266.4 8433.5 8449.8 8455.5 8460.0 8229.0 8315.7 8329.2 8368.1 8379.8 8539.8 8565.8 8626.8 8635.8 8641.7 8463.2 8551.2 8554.7 8560.6 8571.8 8340.4 8508.1 8509.1 8515.4 8522.3 38613.0 39012.6 39019.6 39097.0 39127.6 3223.1 3240.6 3288.2 3594.4 3770.9 27841.2 29093.9 29418.3 29512.0 29520.7 3557.6 3558.4 3672.5 3690.5 3711.6 270279.0 270666.0 271043.0 271337.0 271793.0 55762.8 55903.2 56035.2 56128.7 56149.4 56989.0 57009.0 57419.7 57514.4 57603.4 14807.6 14998.9 15001.2 15004.4 15006.6 10761.7 10845.1 10853.4 10862.4 10874.8 18011.5 18447.4 18538.3 18539.4 18618.6 7593.7 7879.8 7913.2 7926.2 8042.2 936.7 986.9 1028.9 1070.9 1080.6 27962.0 27973.3 28344.3 28444.3 28457.3 901.9 904.8 979.2 1038.9 1046.8 12133.4 12953.9 13505.7 13560.3 13610.9 250083.0 254121.0 254665.0 256555.0 257119.0 47233.3 47594.5 47620.3 47670.8 47731.8 1165.7 1238.6 1274.7 1295.3 1298.2 24759.5 27868.9 28141.2 28384.0 28467.3 39036.8 39269.2 39437.8 39764.0 39819.4 286476.0 291765.0 301798.0 306594.0 306725.7 27726.9 27788.6 27790.6 27844.3 27849.9 35858.8 36805.6 37339.6 37512.2 37564.6 31821.7 31878.7 32070.2 32333.2 32415.7 34390.8 34918.7 35330.3 35364.5 35433.6 33977.8 34287.8 34516.3 34612.5 34853.1 29722.6 30851.5 31297.8 31405.4 31644.4 24100.9 24221.3 24250.0 24437.3 24503.3 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#2] jquery.html Cycles:180 Average:24023.85 Median:4592.92 stddev:71317.73 (1552.8%) stddev-sans-first:71495.67 04:49:53 INFO - PROCESS | 17351 | Values: 367.6 368.8 370.7 371.9 373.2 13852.5 13855.7 15687.8 16476.8 17278.1 10911.2 11189.2 16468.7 16938.7 16955.9 4837.7 4954.9 4955.6 4976.4 4996.7 3776.8 3904.7 4949.7 4998.2 5314.8 5501.5 5502.3 5502.5 5507.4 5534.6 5356.2 5626.3 5628.1 5632.2 5635.4 5222.2 5357.7 5375.6 5390.9 5393.1 11949.7 12424.3 12450.6 20273.3 20411.2 2082.8 2109.1 2140.5 2191.7 2229.9 8971.1 9073.8 9370.0 9451.1 9516.7 1822.9 1841.4 1857.3 1873.3 1945.9 57386.4 58276.1 59047.0 60046.0 60291.4 10223.5 10232.8 10234.5 10256.8 10297.4 13201.9 13303.2 13315.5 13324.0 13337.6 7153.3 7229.2 7291.7 7321.0 7372.8 6800.8 6878.8 6903.5 6944.6 7069.5 4404.2 4478.1 4488.3 4534.8 4563.1 1712.1 1772.9 1836.0 1913.9 1948.3 428.4 431.1 859.8 945.0 953.0 9784.8 9994.7 10519.3 10527.3 10678.9 464.9 469.3 477.8 478.2 481.3 4622.7 6054.8 6240.8 6262.2 6355.7 400050.0 406288.0 407393.0 411261.0 532351.0 71778.0 72433.6 72981.6 74498.6 75132.0 1131.8 1150.9 1162.9 1171.2 1173.7 14922.3 15063.4 15254.2 15340.4 15462.6 33728.0 34028.0 34199.3 34230.0 34378.3 40476.6 42064.4 43117.1 43400.6 44367.3 7099.9 7137.0 7335.5 7500.5 7523.5 8964.6 10221.1 10901.0 10947.4 11269.7 3122.2 3128.8 9253.2 9403.9 9650.2 9690.7 9714.3 9888.1 10122.5 10248.4 8970.8 9079.5 9890.8 10109.3 10224.0 7289.0 7298.0 7344.3 7451.6 7573.3 8893.9 9705.0 9805.2 9879.4 9961.5 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#3] mootools.html Cycles:180 Average:5288.42 Median:6210.58 stddev:2674.57 (43.1%) stddev-sans-first:2665.41 04:49:53 INFO - PROCESS | 17351 | Values: 1317.5 1478.8 1482.5 1660.8 1826.6 6665.4 7197.6 7370.4 7374.3 7378.6 7307.3 7466.6 7467.7 7479.1 7482.3 2006.3 2064.8 2206.2 2304.6 2332.6 2265.6 2268.7 2268.8 2270.0 2271.4 2220.0 2308.5 2309.3 2310.0 2312.2 2276.4 2290.4 2335.8 2354.5 2354.7 2275.7 2311.0 2317.6 2317.9 2321.3 7056.2 7077.3 7089.3 7096.2 7103.4 4602.3 4694.6 4696.2 4699.8 4701.4 3027.1 3049.6 3062.5 3071.7 3182.0 1007.1 1011.6 1014.9 1067.8 1075.2 10180.8 10212.4 10237.2 10239.6 10248.8 4250.3 4339.3 4349.3 4354.0 4387.1 8792.3 8799.8 8807.4 8807.7 8813.3 4867.6 4870.7 4876.1 4883.7 4886.8 4408.2 4408.6 4447.6 4452.8 4456.3 3448.6 3517.9 3610.4 3694.9 3702.9 1207.1 1224.7 1227.0 1236.9 1240.0 1004.6 1019.5 1021.9 1131.9 1309.6 6849.1 6869.7 6872.5 6893.9 6894.9 1178.3 1181.8 1198.3 1220.9 1224.9 5354.0 5362.8 5380.6 5398.5 5411.0 8809.5 9141.3 9264.4 9268.0 9283.6 9055.4 9056.6 9079.9 9116.2 9205.2 6986.7 7445.3 7453.1 7470.5 7501.4 6793.7 6795.2 6820.5 6834.6 6838.6 8189.0 8291.6 8467.1 8581.0 8619.4 8396.8 8496.2 8517.7 8521.3 8525.3 6285.2 6426.3 6426.8 6431.9 6432.8 6371.8 6578.7 6872.2 6910.9 7111.3 6580.5 6634.8 6713.5 6722.2 6756.4 6462.1 6499.8 6527.9 6611.4 6647.8 6558.5 6563.8 6574.4 6577.0 6585.2 6245.5 6260.7 6270.9 6275.5 6278.8 6175.6 6298.4 6304.4 6315.2 6319.2 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#4] prototype.html Cycles:180 Average:5199.21 Median:5831.07 stddev:1560.37 (26.8%) stddev-sans-first:1521.51 04:49:53 INFO - PROCESS | 17351 | Values: 339.3 342.9 349.3 349.7 353.9 5827.2 5894.4 5911.2 5937.3 5944.0 5581.6 5728.1 5733.7 5768.9 5815.1 4416.6 4462.9 4496.6 4519.1 4540.1 4516.4 4520.6 4528.8 4540.7 4542.9 4305.2 4394.5 4496.3 4505.1 4515.1 4393.1 4429.6 4456.3 4470.6 4480.8 3982.4 3986.3 3986.4 3995.9 3996.7 5595.9 5601.8 5603.2 5617.5 5625.5 5085.0 5197.5 5238.2 5245.9 5246.4 6147.2 6150.8 6153.5 6156.8 6158.5 4300.8 4303.2 4308.5 4310.3 4351.1 6359.5 6407.8 6416.1 6426.3 6432.2 4322.1 4404.2 4410.1 4413.6 4432.7 4458.9 4472.9 4479.7 4479.9 4481.9 5158.8 5162.9 5163.1 5163.9 5167.5 6182.8 6190.4 6191.6 6193.9 6195.7 1530.8 1580.9 1582.7 1584.4 1589.4 1050.3 1073.3 1076.3 1086.3 1088.1 5813.8 5821.6 5831.1 5834.1 5836.1 6288.7 6290.0 6293.6 6296.3 6299.9 5697.6 5826.7 5831.1 5834.2 5877.7 3354.9 3411.5 3423.4 3434.0 3445.6 6632.3 6662.8 6670.8 6672.8 6683.9 6420.4 6487.9 6531.5 6534.4 6539.5 6663.0 6666.3 6676.6 6681.6 6692.6 6352.8 6376.7 6378.6 6381.3 6389.2 6172.2 6312.5 6316.9 6318.5 6319.4 6716.1 6721.4 6722.6 6726.9 6729.7 4463.0 4499.9 4501.9 4503.4 4509.9 6462.9 6470.0 6474.6 6475.6 6491.0 6134.8 6305.0 6305.2 6307.8 6311.1 6272.7 6274.5 6280.2 6281.0 6281.9 6006.1 6179.5 6186.9 6194.0 6196.1 6299.9 6301.0 6310.4 6320.7 6325.4 6167.6 6169.4 6174.4 6175.4 6186.9 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - PROCESS | 17351 | [#5] yui.html Cycles:180 Average:13556.99 Median:48638.63 stddev:15567.78 (32.0%) stddev-sans-first:15582.06 04:49:53 INFO - PROCESS | 17351 | Values: 819.1 824.9 832.0 851.6 888.4 12576.1 12716.6 12731.7 12734.7 12778.6 11687.6 11958.4 11990.8 12002.0 12021.9 654.0 807.9 822.1 823.5 824.2 799.0 806.6 807.0 807.0 816.4 697.3 704.3 848.0 853.1 854.5 837.8 844.7 847.6 849.0 849.9 624.7 630.4 631.0 631.4 631.8 12374.2 12397.9 12399.2 12401.1 12409.6 12252.8 12358.0 12668.6 12873.4 13246.1 10288.3 10373.6 10431.2 10944.7 11026.0 3576.6 3639.5 3656.1 3737.5 3738.2 48551.8 49981.8 50045.5 50067.7 50431.7 9552.6 9596.5 9726.8 9746.2 9965.8 16348.3 16349.3 16417.8 16443.6 16444.5 7153.7 7268.9 7355.7 7405.8 7506.4 4183.2 4234.7 4243.4 4252.6 4267.9 3059.1 3075.9 3076.2 3085.2 3089.2 541.5 553.2 556.3 559.2 564.9 545.1 564.4 575.7 637.7 672.2 8359.9 9205.6 9232.6 9707.3 9757.2 503.5 611.3 693.5 698.8 751.4 3905.4 3975.6 4194.2 4206.3 4231.2 54112.5 54136.0 54407.0 54548.0 54724.0 48725.5 49023.0 49216.3 50763.2 51298.0 45710.4 46320.0 46389.8 47571.0 48067.8 8654.3 8725.9 8755.3 8785.6 8915.2 33518.0 33839.5 34270.3 34545.1 34854.8 40252.8 40473.4 42658.8 43033.6 43563.8 11331.9 11355.9 11422.5 11788.3 11807.5 12185.3 12642.7 12793.3 13027.7 13029.3 11415.6 11676.8 11718.6 11756.4 12058.7 10785.7 11026.9 11239.2 11405.7 11524.7 10891.6 11213.4 11356.5 11615.1 11618.4 9515.7 9717.1 9811.4 9816.5 9931.6 8817.7 9112.3 9282.0 9699.5 9765.5 04:49:53 INFO - PROCESS | 17351 | -------- Summary: end -------- 04:49:53 INFO - PROCESS | 17351 | 04:49:53 INFO - TEST-INFO | 17351: exit 0 04:49:53 INFO - TEST-OK | dromaeo_css | took 1112282ms 04:49:53 INFO - TEST-START | kraken 04:49:53 INFO - operating with platform_type : linux_ 04:49:53 INFO - Initialising browser for kraken test... 04:49:53 INFO - TEST-INFO | started process 17548 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Aon7E/profile http://localhost:57542/getInfo.html) 04:49:57 INFO - PROCESS | 17548 | __metrics Screen width/height:1600/1200 04:49:57 INFO - PROCESS | 17548 | colorDepth:24 04:49:57 INFO - PROCESS | 17548 | Browser inner width/height: 1024/697 04:49:57 INFO - PROCESS | 17548 | __metrics 04:49:57 INFO - PROCESS | 17548 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:49:57 INFO - PROCESS | 17548 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:49:59 INFO - TEST-INFO | 17548: exit 0 04:49:59 INFO - Browser initialized. 04:49:59 INFO - Running cycle 1/1 for kraken test... 04:49:59 INFO - TEST-INFO | started process 17629 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2Aon7E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:10 INFO - PROCESS | 17629 | RSS: Main: 148692992 04:50:10 INFO - PROCESS | 17629 | 04:50:13 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57542/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:13 INFO - PROCESS | 17629 | RSS: Main: 187604992 04:50:13 INFO - PROCESS | 17629 | 04:50:16 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57542/tests/kraken/driver.html?testName=audio-dft) 04:50:17 INFO - PROCESS | 17629 | RSS: Main: 179392512 04:50:17 INFO - PROCESS | 17629 | 04:50:20 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57542/tests/kraken/driver.html?testName=audio-fft) 04:50:20 INFO - PROCESS | 17629 | RSS: Main: 161697792 04:50:20 INFO - PROCESS | 17629 | 04:50:22 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57542/tests/kraken/driver.html?testName=audio-oscillator) 04:50:23 INFO - PROCESS | 17629 | RSS: Main: 163217408 04:50:23 INFO - PROCESS | 17629 | 04:50:25 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57542/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:25 INFO - PROCESS | 17629 | RSS: Main: 165613568 04:50:25 INFO - PROCESS | 17629 | 04:50:28 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57542/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:29 INFO - PROCESS | 17629 | RSS: Main: 164827136 04:50:29 INFO - PROCESS | 17629 | 04:50:32 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57542/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:33 INFO - PROCESS | 17629 | RSS: Main: 165376000 04:50:33 INFO - PROCESS | 17629 | 04:50:36 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57542/tests/kraken/driver.html?testName=json-parse-financial) 04:50:36 INFO - PROCESS | 17629 | RSS: Main: 165363712 04:50:36 INFO - PROCESS | 17629 | 04:50:38 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57542/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:38 INFO - PROCESS | 17629 | RSS: Main: 180518912 04:50:38 INFO - PROCESS | 17629 | 04:50:40 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:41 INFO - PROCESS | 17629 | RSS: Main: 179535872 04:50:41 INFO - PROCESS | 17629 | 04:50:43 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:43 INFO - PROCESS | 17629 | RSS: Main: 190103552 04:50:43 INFO - PROCESS | 17629 | 04:50:46 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:46 INFO - PROCESS | 17629 | RSS: Main: 194310144 04:50:46 INFO - PROCESS | 17629 | 04:50:49 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:49 INFO - PROCESS | 17629 | RSS: Main: 192122880 04:50:49 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | Cycle 1(1): loaded http://localhost:57542/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57542/tests/kraken/driver.html?testName=ai-astar) 04:50:51 INFO - PROCESS | 17629 | RSS: Main: 251568128 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | __start_tp_report 04:50:51 INFO - PROCESS | 17629 | _x_x_mozilla_page_load 04:50:51 INFO - PROCESS | 17629 | _x_x_mozilla_page_load_details 04:50:51 INFO - PROCESS | 17629 | |i|pagename|runs| 04:50:51 INFO - PROCESS | 17629 | |0;ai-astar;113;109;105;108;111;110;110;110;104;109 04:50:51 INFO - PROCESS | 17629 | |1;audio-beat-detection;151;134;153;161;125;146;161;130;171;124 04:50:51 INFO - PROCESS | 17629 | |2;audio-dft;161;160;161;162;161;161;162;162;162;163 04:50:51 INFO - PROCESS | 17629 | |3;audio-fft;72;73;127;89;72;74;71;108;94;73 04:50:51 INFO - PROCESS | 17629 | |4;audio-oscillator;96;95;136;96;95;96;143;95;96;140 04:50:51 INFO - PROCESS | 17629 | |5;imaging-gaussian-blur;110;109;109;109;110;109;109;109;109;109 04:50:51 INFO - PROCESS | 17629 | |6;imaging-darkroom;146;145;147;145;145;145;145;146;146;146 04:50:51 INFO - PROCESS | 17629 | |7;imaging-desaturate;95;95;95;96;97;95;96;97;96;96 04:50:51 INFO - PROCESS | 17629 | |8;json-parse-financial;56;55;56;55;63;56;56;55;56;54 04:50:51 INFO - PROCESS | 17629 | |9;json-stringify-tinderbox;66;67;67;67;67;68;68;68;68;68 04:50:51 INFO - PROCESS | 17629 | |10;stanford-crypto-aes;88;87;80;82;81;81;81;82;82;83 04:50:51 INFO - PROCESS | 17629 | |11;stanford-crypto-ccm;114;116;115;114;119;121;117;124;114;130 04:50:51 INFO - PROCESS | 17629 | |12;stanford-crypto-pbkdf2;144;148;146;141;144;132;144;141;142;147 04:50:51 INFO - PROCESS | 17629 | |13;stanford-crypto-sha256-iterative;69;67;68;68;67;65;65;67;66;66 04:50:51 INFO - PROCESS | 17629 | __end_tp_report 04:50:51 INFO - PROCESS | 17629 | __start_cc_report 04:50:51 INFO - PROCESS | 17629 | _x_x_mozilla_cycle_collect,926 04:50:51 INFO - PROCESS | 17629 | __end_cc_report 04:50:51 INFO - PROCESS | 17629 | __startTimestamp1453121451780__endTimestamp 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | ------- Summary: start ------- 04:50:51 INFO - PROCESS | 17629 | Number of tests: 14 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:2.69 (2.4%) stddev-sans-first:2.40 04:50:51 INFO - PROCESS | 17629 | Values: 113.0 109.0 105.0 108.0 111.0 110.0 110.0 110.0 104.0 109.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:152.00 stddev:16.57 (10.9%) stddev-sans-first:17.46 04:50:51 INFO - PROCESS | 17629 | Values: 151.0 134.0 153.0 161.0 125.0 146.0 161.0 130.0 171.0 124.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 04:50:51 INFO - PROCESS | 17629 | Values: 161.0 160.0 161.0 162.0 161.0 161.0 162.0 162.0 162.0 163.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#3] audio-fft Cycles:10 Average:85.30 Median:73.00 stddev:19.24 (26.4%) stddev-sans-first:19.80 04:50:51 INFO - PROCESS | 17629 | Values: 72.0 73.0 127.0 89.0 72.0 74.0 71.0 108.0 94.0 73.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:95.50 stddev:21.37 (22.4%) stddev-sans-first:22.16 04:50:51 INFO - PROCESS | 17629 | Values: 96.0 95.0 136.0 96.0 95.0 96.0 143.0 95.0 96.0 140.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:50:51 INFO - PROCESS | 17629 | Values: 110.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 04:50:51 INFO - PROCESS | 17629 | Values: 146.0 145.0 147.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.78 04:50:51 INFO - PROCESS | 17629 | Values: 95.0 95.0 95.0 96.0 97.0 95.0 96.0 97.0 96.0 96.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:2.49 (4.4%) stddev-sans-first:2.64 04:50:51 INFO - PROCESS | 17629 | Values: 56.0 55.0 56.0 55.0 63.0 56.0 56.0 55.0 56.0 54.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 04:50:51 INFO - PROCESS | 17629 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:2.67 (3.3%) stddev-sans-first:2.03 04:50:51 INFO - PROCESS | 17629 | Values: 88.0 87.0 80.0 82.0 81.0 81.0 81.0 82.0 82.0 83.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.00 stddev:5.27 (4.5%) stddev-sans-first:5.35 04:50:51 INFO - PROCESS | 17629 | Values: 114.0 116.0 115.0 114.0 119.0 121.0 117.0 124.0 114.0 130.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.90 Median:144.00 stddev:4.51 (3.1%) stddev-sans-first:4.76 04:50:51 INFO - PROCESS | 17629 | Values: 144.0 148.0 146.0 141.0 144.0 132.0 144.0 141.0 142.0 147.0 04:50:51 INFO - PROCESS | 17629 | 04:50:51 INFO - PROCESS | 17629 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.32 (2.0%) stddev-sans-first:1.13 04:50:51 INFO - PROCESS | 17629 | Values: 69.0 67.0 68.0 68.0 67.0 65.0 65.0 67.0 66.0 66.0 04:50:51 INFO - PROCESS | 17629 | -------- Summary: end -------- 04:50:51 INFO - PROCESS | 17629 | 04:50:52 INFO - TEST-INFO | 17629: exit 0 04:50:52 INFO - TEST-OK | kraken | took 58681ms 04:50:52 INFO - TEST-START | v8_7 04:50:52 INFO - operating with platform_type : linux_ 04:50:52 INFO - Initialising browser for v8_7 test... 04:50:52 INFO - TEST-INFO | started process 17879 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeq_NHs/profile http://localhost:57542/getInfo.html) 04:50:56 INFO - PROCESS | 17879 | __metrics Screen width/height:1600/1200 04:50:56 INFO - PROCESS | 17879 | colorDepth:24 04:50:56 INFO - PROCESS | 17879 | Browser inner width/height: 1024/697 04:50:56 INFO - PROCESS | 17879 | __metrics 04:50:56 INFO - PROCESS | 17879 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:50:56 INFO - PROCESS | 17879 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:57 INFO - TEST-INFO | 17879: exit 0 04:50:57 INFO - Browser initialized. 04:50:57 INFO - Running cycle 1/1 for v8_7 test... 04:50:57 INFO - TEST-INFO | started process 17964 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeq_NHs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:09 INFO - PROCESS | 17964 | RSS: Main: 149524480 04:51:09 INFO - PROCESS | 17964 | 04:51:31 INFO - PROCESS | 17964 | Cycle 1(1): loaded http://localhost:57542/tests/v8_7/run.html (next: http://localhost:57542/tests/v8_7/run.html) 04:51:32 INFO - PROCESS | 17964 | RSS: Main: 553279488 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | __start_tp_report 04:51:32 INFO - PROCESS | 17964 | _x_x_mozilla_page_load 04:51:32 INFO - PROCESS | 17964 | _x_x_mozilla_page_load_details 04:51:32 INFO - PROCESS | 17964 | |i|pagename|runs| 04:51:32 INFO - PROCESS | 17964 | |0;Richards;166.8335001668335 04:51:32 INFO - PROCESS | 17964 | |1;DeltaBlue;188.11136192626034 04:51:32 INFO - PROCESS | 17964 | |2;Encrypt;278.8622420524261 04:51:32 INFO - PROCESS | 17964 | |3;Decrypt;5175.257731958763 04:51:32 INFO - PROCESS | 17964 | |4;RayTrace;1964.6365422396857 04:51:32 INFO - PROCESS | 17964 | |5;Earley;785.5459544383347 04:51:32 INFO - PROCESS | 17964 | |6;Boyer;12231.707317073171 04:51:32 INFO - PROCESS | 17964 | |7;RegExp;42833.333333333336 04:51:32 INFO - PROCESS | 17964 | |8;Splay;582.0721769499418 04:51:32 INFO - PROCESS | 17964 | |9;NavierStokes;4835.748792270531 04:51:32 INFO - PROCESS | 17964 | __end_tp_report 04:51:32 INFO - PROCESS | 17964 | __startTimestamp1453121492143__endTimestamp 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | ------- Summary: start ------- 04:51:32 INFO - PROCESS | 17964 | Number of tests: 10 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 166.8 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 188.1 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#2] Encrypt Cycles:1 Average:278.86 Median:278.86 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 278.9 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 5175.3 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 1964.6 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 785.5 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 12231.7 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#7] RegExp Cycles:1 Average:42833.33 Median:42833.33 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 42833.3 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#8] Splay Cycles:1 Average:582.07 Median:582.07 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 582.1 04:51:32 INFO - PROCESS | 17964 | 04:51:32 INFO - PROCESS | 17964 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:51:32 INFO - PROCESS | 17964 | Values: 4835.7 04:51:32 INFO - PROCESS | 17964 | -------- Summary: end -------- 04:51:32 INFO - PROCESS | 17964 | 04:51:33 INFO - TEST-INFO | 17964: exit 0 04:51:33 INFO - TEST-OK | v8_7 | took 40401ms 04:51:33 INFO - SUITE-END | took 1211s 04:51:33 INFO - Completed test suite (00:20:11) 04:51:33 INFO - Working with test: dromaeo_css 04:51:33 INFO - Generating results file: dromaeo_css 04:51:33 INFO - Working with test: kraken 04:51:33 INFO - Generating results file: kraken 04:51:33 INFO - javascript benchmark 04:51:33 INFO - Working with test: v8_7 04:51:33 INFO - Generating results file: v8_7 04:51:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 04:51:33 INFO - process_Request line: dromaeo_css 6638.35 graph.html#tests=[[72,1,35]] 04:51:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:33 INFO - process_Request line: kraken 1495.10 graph.html#tests=[[232,1,35]] 04:51:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:33 INFO - process_Request line: v8_7 18999.59 graph.html#tests=[[230,1,35]] 04:51:33 INFO - RETURN: dromaeo_css: 6638.35 04:51:33 INFO - RETURN: kraken: 1495.10 04:51:33 INFO - RETURN: v8_7: 18999.59 04:51:33 INFO - javascript benchmark 04:51:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3091.2117410060437, 3091.7526597872175, 3149.2441813964642, 3159.210197450637, 3175.618925728913, 5020.874478138048, 5038.34501514803, 5062.772175252108, 5104.846854594359, 5110.667806592569, 5069.0, 5105.004524117799, 5106.5659418949435, 5108.361454818148, 5117.3091632629585, 4482.260427029552, 4644.326572646964, 4646.976765116178, 4688.062387522509, 4714.882127946795, 4597.701149425294, 4619.815207391717, 4625.074985002996, 4681.016986432854, 4767.928481072787, 4575.565321294472, 4637.884052898671, 4651.8837029074375, 4663.953360466386, 4683.929741053887, 4641.559051890065, 4645.488996210414, 4655.185342565038, 4678.298255261704, 4680.695754775928, 4589.678722489427, 4640.535946405366, 4652.13935421948, 4663.160631086403, 4684.765761711901, 4918.704877707313, 4980.377452818398, 4994.475580064077, 5000.74996250186, 5049.84850454487, 5509.862253443656, 5511.669299842022, 5518.724063796834, 5525.364583072917, 5572.275604171432, 5397.892042159174, 5492.258545096401, 5493.505584497414, 5557.472040156219, 5559.0, 5122.718250496221, 5129.333186685782, 5141.100307446182, 5144.382674079097, 5182.663126896778, 5579.995600791896, 5580.1629755537, 5581.469760372758, 5594.300712410949, 5597.80407685729, 5313.07021271276, 5373.247745315659, 5386.461353864583, 5390.4879036491475, 5480.095784195563, 5418.458154184629, 5471.179323101566, 5471.452854714496, 5476.726163691799, 5481.561475081984, 5449.6730196188355, 5485.040117979417, 5485.50630443262, 5491.780328786884, 5541.224228607998, 5390.245365648812, 5444.210589464585, 5458.563314934875, 5461.535769459561, 5537.640053396516, 4281.785910704452, 4290.957090429119, 4294.312909934395, 4298.699091063658, 4340.82636694535, 3762.981185094057, 3827.61723827615, 3835.7890316032885, 3859.0352411897024, 3874.1670540833293, 5075.87310317245, 5132.461091585405, 5137.12668846297, 5155.536001759785, 5192.221166824931, 5442.8095016675015, 5471.935715998974, 5501.532369748536, 5504.697241651747, 5504.889902201933, 4973.303737476756, 5036.79852805891, 5142.5628821549835, 5147.3308469898675, 5155.871103222375, 4688.0, 4708.717476951394, 4734.147853386424, 4739.075880203327, 4772.522747725269, 5653.434656534314, 5678.318601767732, 5681.460261275172, 5683.318001839723, 5734.369219385864, 5418.918716219181, 5441.047816632153, 5447.482489163682, 5450.5367043801725, 5493.560515158698, 5692.544596432358, 5697.686627235376, 5709.628874123168, 5710.3433105193435, 5719.456651618089, 5350.411454739898, 5362.222477740628, 5391.892162156813, 5394.757235924314, 5398.352197736297, 5407.891842163056, 5441.428649991693, 5490.066688662857, 5508.752106155152, 5535.944640553543, 5379.273798037371, 5383.784648614168, 5383.919241211307, 5388.811391601275, 5389.649672771257, 5368.516833485005, 5376.247325374529, 5380.838574842761, 5382.946170538245, 5421.728913554385, 5168.198929165986, 5288.365396152486, 5295.311609490742, 5313.203019547099, 5377.569794416516, 5291.920621190762, 5319.734013299397, 5321.840344789663, 5344.0, 5379.865503362447, 5222.55608273301, 5227.581793456438, 5227.973860130675, 5246.3704355477585, 5265.89468210626], "unit": "score", "name": "dojo.html", "value": 5056.611405984244}, {"lowerIsBetter": false, "replicates": [516.1328967334875, 532.6298222735201, 538.0610834094506, 559.829955393228, 563.2677519225008, 30558.083257502283, 31145.84427077864, 35652.2869542609, 35694.82152589237, 35757.64242357576, 38019.239615207676, 38431.615683843156, 38552.421713674245, 38609.22781544367, 38712.22575548488, 8266.380021498397, 8433.536155511445, 8449.788755281106, 8455.492670439793, 8459.957700211491, 8228.958855205716, 8315.708950186745, 8329.208725171098, 8368.079511253758, 8379.790505237388, 8539.829203415928, 8565.8007878897, 8626.78433039176, 8635.784105397384, 8641.740747777545, 8463.153684631548, 8551.187637174458, 8554.743357699279, 8560.61477233526, 8571.828563428697, 8340.416170868042, 8508.106648801848, 8509.106543812934, 8515.361347898932, 8522.318214542822, 38613.0, 39012.60987390118, 39019.60980390188, 39097.0, 39127.60872391296, 3223.06531105979, 3240.5985995701576, 3288.1943923738836, 3594.388953877847, 3770.8680196193, 27841.16476505708, 29093.85453072742, 29418.264543386373, 29512.0, 29520.704792952227, 3557.6086630470627, 3558.3594952908466, 3672.467492213641, 3690.538682664667, 3711.6473934976134, 270279.0, 270666.0, 271043.0, 271337.0, 271793.0, 55762.76948922079, 55903.16145257824, 56035.15947260794, 56128.71935640296, 56149.43850561524, 56989.0, 57009.0, 57419.712901435225, 57514.424855750905, 57603.42396575981, 14807.629809254855, 14998.850011499964, 15001.249937503082, 15004.399824007136, 15006.62483437901, 10761.730956725987, 10845.132389408986, 10853.40306283162, 10862.402567858844, 10874.782504349869, 18011.459656210336, 18447.446576602724, 18538.258469661334, 18539.443816685252, 18618.627627447375, 7593.6582853771715, 7879.803004924923, 7913.169117242722, 7926.24700653437, 8042.195780421911, 936.7054730362677, 986.9457179855177, 1028.8508166315842, 1070.882202957674, 1080.6055789636725, 27962.0, 27973.30066748307, 28344.291392715346, 28444.288892777433, 28457.288567785556, 901.8917729872458, 904.7738065483629, 979.1872745621117, 1038.8597539332093, 1046.8482070099792, 12133.393330333449, 12953.935230323788, 13505.662358441117, 13560.321983900765, 13610.93194534021, 250083.0, 254121.0, 254665.0, 256555.0, 257119.0, 47233.29150062752, 47594.5240547597, 47620.28569571459, 47670.761646191546, 47731.76134119307, 1165.6794381544973, 1238.646985609097, 1274.6877015131352, 1295.3264302562616, 1298.2016060122955, 24759.50480990406, 27868.88524458999, 28141.155765327072, 28384.0, 28467.28831779222, 39036.80481597574, 39269.21461570695, 39437.80281098576, 39764.0, 39819.40270895997, 286476.0, 291765.0, 301798.0, 306594.0, 306725.73097075865, 27726.861365693043, 27788.58317125204, 27790.583141252493, 27844.30389240204, 27849.860750696927, 35858.8207058963, 36805.63194368022, 37339.62660373362, 37512.249755005294, 37564.62435375611, 31821.681783181873, 31878.68121318757, 32070.198245043128, 32333.191670208435, 32415.67584324221, 34390.82804586061, 34918.65081349154, 35330.29339413249, 35364.469532956515, 35433.64566354304, 33977.772111649356, 34287.82856085704, 34516.30967380588, 34612.48081278833, 34853.1286717824, 29722.55416168716, 30851.537226941164, 31297.8435107823, 31405.371892562478, 31644.367112657157, 24100.87949560241, 24221.273361799173, 24250.0, 24437.266881993568, 24503.264902052968], "unit": "score", "name": "ext.html", "value": 17431.570391345158}, {"lowerIsBetter": false, "replicates": [367.57545035484026, 368.83402468889005, 370.6775105658078, 371.8921512761298, 373.19390117346535, 13852.515161969333, 13855.653608659788, 15687.764683529756, 16476.752848707263, 17278.136093195353, 10911.236213465061, 11189.16081293902, 16468.670626587493, 16938.745918811226, 16955.91522042388, 4837.709737415748, 4954.851354459372, 4955.628327875405, 4976.402831660206, 4996.65023448357, 3776.773393596393, 3904.7461914975434, 4949.653524253304, 4998.22527508235, 5314.7608357624, 5501.504864562188, 5502.312210973629, 5502.477264659871, 5507.421720719327, 5534.557235421156, 5356.1697936819855, 5626.2685850839125, 5628.099504079328, 5632.211490391349, 5635.380108188096, 5222.164453687392, 5357.651752636066, 5375.623706340558, 5390.946090539122, 5393.1101368274185, 11949.701257468545, 12424.254544727346, 12450.564230251897, 20273.290434834857, 20411.183552657876, 2082.833373330145, 2109.0720083163515, 2140.464883779055, 2191.6822060801096, 2229.944251393712, 8971.102889711043, 9073.81852362949, 9369.953150234272, 9451.149396554343, 9516.666916657883, 1822.9453116406528, 1841.4475657302755, 1857.322077441724, 1873.3349660870467, 1945.873518221311, 57386.426135738526, 58276.125858112166, 59047.0, 60046.0, 60291.39708602946, 10223.539940702687, 10232.795344093225, 10234.48827558619, 10256.846147307797, 10297.433641149808, 13201.933990329986, 13303.201807891557, 13315.467381304834, 13324.0, 13337.599872003855, 7153.284671532909, 7229.2409297024105, 7291.671874765649, 7321.048263725682, 7372.815679608053, 6800.761973330909, 6878.793636190822, 6903.516753827284, 6944.618046007417, 7069.469789765788, 4404.207242696281, 4478.149151661174, 4488.259437192892, 4534.77326133692, 4563.110193512233, 1712.0918810263295, 1772.9024903630425, 1836.0250058623199, 1913.885166889991, 1948.2693989753843, 428.3874060094033, 431.0516862901629, 859.8108416148438, 944.9952750236205, 952.9904700952902, 9784.804303913881, 9994.650187243557, 10519.26365154432, 10527.315724478038, 10678.893211067945, 464.8814552289145, 469.3452633576142, 477.79932428380164, 478.1584411435828, 481.2636665901177, 4622.722636641813, 6054.757809687651, 6240.7503699851495, 6262.2172228471445, 6355.713992870332, 400050.0, 406288.0, 407393.0, 411261.0, 532351.0, 71778.0, 72433.6378318105, 72981.6350918242, 74498.62750686321, 75132.0, 1131.8019346614474, 1150.916840518664, 1162.918595698293, 1171.2211379432752, 1173.7359094203907, 14922.25388730581, 15063.397464101314, 15254.237288135771, 15340.386384544494, 15462.613434663774, 33728.0, 34028.0, 34199.31601368009, 34230.0, 34378.312433751686, 40476.59523404728, 42064.36903446512, 43117.13765724605, 43400.56599433965, 44367.33448998203, 7099.929000709927, 7137.0, 7335.496223274109, 7500.512466689648, 7523.473356864967, 8964.641414343354, 10221.080102790487, 10901.0, 10947.397893115955, 11269.66191014271, 3122.157017605279, 3128.7966282191583, 9253.213476854542, 9403.905960940303, 9650.227981761582, 9690.70927872165, 9714.311297712293, 9888.110070093726, 10122.493875306352, 10248.436336001592, 8970.820583588422, 9079.45523268606, 9890.75273118149, 10109.342892712244, 10224.028717271847, 7289.0, 7297.963510182628, 7344.265573442826, 7451.627418628938, 7573.2805383488485, 8893.866592000995, 9704.95147524286, 9805.21558275322, 9879.407235565888, 9961.452120133463], "unit": "score", "name": "jquery.html", "value": 7530.697360480153}, {"lowerIsBetter": false, "replicates": [1317.4927652853648, 1478.8373278939314, 1482.5181815909825, 1660.7508873668949, 1826.5707558723707, 6665.40011398974, 7197.60413177275, 7370.410367170627, 7374.262573742623, 7378.557286562804, 7307.269273072703, 7466.6266686665585, 7467.701291948316, 7479.065116860393, 7482.2517748225155, 2006.2877678424168, 2064.8038436348525, 2206.161658569741, 2304.6082166031815, 2332.568474832153, 2265.5808675395024, 2268.6823844661762, 2268.8298377621663, 2269.9773002270013, 2271.3753717727673, 2220.0, 2308.492131731025, 2309.2956648222284, 2310.0182422470466, 2312.1791763923816, 2276.4195130241765, 2290.4159439342943, 2335.8131349492087, 2354.482013956927, 2354.6703461515403, 2275.6927814745127, 2310.988445057764, 2317.606006978801, 2317.9072837086496, 2321.292005938188, 7056.223815380304, 7077.292270772933, 7089.291070892921, 7096.219415864251, 7103.431725462003, 4602.286645569942, 4694.624430045588, 4696.201645720202, 4699.812007519695, 4701.412323459567, 3027.1070034339923, 3049.557814116941, 3062.525308577174, 3071.66211716711, 3181.984090079558, 1007.0885848307221, 1011.5801942193981, 1014.8582844300163, 1067.8184708599556, 1075.2204651627585, 10180.847287290697, 10212.438315892623, 10237.232207584386, 10239.641612543599, 10248.846267305997, 4250.341197114452, 4339.284018137035, 4349.282368409177, 4354.0, 4387.056782791651, 8792.340574456814, 8799.824003520022, 8807.383483156245, 8807.69173078952, 8813.294936405073, 4867.58625516835, 4870.683405578697, 4876.122297986326, 4883.658143929891, 4886.755662216946, 4408.162449134654, 4408.647308215335, 4447.599716025573, 4452.844150454718, 4456.331550267486, 3448.620651728308, 3517.9120521986642, 3610.422332426799, 3694.9261014779554, 3702.9444558331647, 1207.1067410116625, 1224.7121926347302, 1227.0429065329058, 1236.8886800188027, 1239.9690007749878, 1004.603181743222, 1019.5310157327564, 1021.9437930913722, 1131.852859128308, 1309.594025851989, 6849.1096157499205, 6869.690863911136, 6872.518923675295, 6893.931060689329, 6894.896576551356, 1178.2753606531921, 1181.7813704464702, 1198.328935795957, 1220.885615475852, 1224.9142560020714, 5354.0, 5362.839114826562, 5380.623356365017, 5398.541124004503, 5410.97294513525, 8809.515476648847, 9141.314401419788, 9264.397814142194, 9267.953660231791, 9283.628654853865, 9055.411398259092, 9056.637734490678, 9079.909200908038, 9116.225120864668, 9205.217556507638, 6986.685599148051, 7445.287583855744, 7453.068366454193, 7470.514416562906, 7501.362384197404, 6793.6942837573415, 6795.1845778506895, 6820.454363650797, 6834.624095674786, 6838.589684618939, 8188.959055204686, 8291.626876790438, 8467.068622451403, 8581.0, 8619.439736417113, 8396.832063358577, 8496.235338819288, 8517.659293628185, 8521.275691566287, 8525.275351595184, 6285.182926219562, 6426.29310775805, 6426.807195784134, 6431.871362572816, 6432.807015789534, 6371.776987805404, 6578.7368505261165, 6872.209695885037, 6910.896336554855, 7111.2533184017, 6580.5064620152725, 6634.83412914681, 6713.530052896251, 6722.193336799615, 6756.425703815231, 6462.063000864754, 6499.837504062436, 6527.869442611216, 6611.371919667624, 6647.767328143492, 6558.475321974135, 6563.835904102436, 6574.3754343337305, 6577.046328282468, 6585.176852893388, 6245.531585131224, 6260.68696565179, 6270.905936411049, 6275.466585340298, 6278.811635650938, 6175.62946223228, 6298.370162983848, 6304.401081897213, 6315.179026726496, 6319.210098737658], "unit": "score", "name": "mootools.html", "value": 4397.589660100842}, {"lowerIsBetter": false, "replicates": [339.25025693217987, 342.8851334802841, 349.3414912889203, 349.7114880223815, 353.90642913397596, 5827.242458480397, 5894.410558944109, 5911.172435858973, 5937.257842769648, 5943.970280148593, 5581.609287349887, 5728.054870946289, 5733.713314334287, 5768.913466298009, 5815.127730840376, 4416.624586910117, 4462.933056004163, 4496.572825581565, 4519.050999290153, 4540.069285796404, 4516.41286632739, 4520.57054579816, 4528.773561321937, 4540.659450541206, 4542.8864278392975, 4305.203537345586, 4394.450693663292, 4496.303073023671, 4505.053938672866, 4515.119551687422, 4393.1213757248515, 4429.623482004034, 4456.331550267453, 4470.597646211857, 4480.775961201944, 3982.362821948503, 3986.3422535281934, 3986.4452863383303, 3995.9400608990886, 3996.7002474814212, 5595.860103497404, 5601.80393686219, 5603.2435621191025, 5617.494425501724, 5625.5218306444, 5084.9745751271, 5197.48025197481, 5238.188080847474, 5245.895082098375, 5246.449122842123, 6147.2008638877105, 6150.815475535696, 6153.476954458876, 6156.7537298508005, 6158.538109641795, 4300.80646370914, 4303.182395344875, 4308.504521979981, 4310.331898555697, 4351.064521127941, 6359.491240700779, 6407.8398040048905, 6416.101745755598, 6426.325235850215, 6432.195975503062, 4322.092360604245, 4404.185225733249, 4410.095930334273, 4413.624841888475, 4432.734035957853, 4458.910821783546, 4472.910541789146, 4479.731216127043, 4479.865604031885, 4481.887952801206, 5158.845234642967, 5162.870928226749, 5163.070647283525, 5163.922541161885, 5167.457416971164, 6182.783602573978, 6190.380961903864, 6191.628502289877, 6193.876122477525, 6195.690215489298, 1530.7856900034003, 1580.936762529509, 1582.7151112799806, 1584.4216860845938, 1589.36425429829, 1050.2700623066896, 1073.2540884085643, 1076.3057827701246, 1086.255914698434, 1088.0642647323295, 5813.82558523245, 5821.621594596338, 5831.067029275296, 5834.066549352084, 5836.095405212199, 6288.685565721696, 6289.96855015722, 6293.590916590407, 6296.307406185316, 6299.905501417483, 5697.601167918206, 5826.65040097587, 5831.067029275296, 5834.212381328552, 5877.735501902424, 3354.9496757548654, 3411.5053317268857, 3423.400904841643, 3433.9828300858835, 3445.638207988125, 6632.2704502504685, 6662.800115996528, 6670.83322916931, 6672.766453174116, 6683.866322673519, 6420.422162005442, 6487.870242595121, 6531.5427920046095, 6534.444572211415, 6539.5422320438065, 6662.966685166543, 6666.300038495985, 6676.599404035774, 6681.5656982296, 6692.5984440932725, 6352.809415717536, 6376.74493020274, 6378.585391949508, 6381.329960354282, 6389.201349831271, 6172.197614310111, 6312.495000400048, 6316.873662526816, 6318.526110541636, 6319.399657032574, 6716.126903502513, 6721.361470660279, 6722.630255336004, 6726.8990965136545, 6729.663516824237, 4462.955370446384, 4499.865004049753, 4501.864944051684, 4503.392042074278, 4509.90980180388, 6462.870742585216, 6469.967650161907, 6474.643894585843, 6475.579087359495, 6491.026346048131, 6134.754609815557, 6305.022721478178, 6305.211848518935, 6307.779227727191, 6311.147995020613, 6272.717727702173, 6274.529410294337, 6280.183576135256, 6281.0, 6281.874362512815, 6006.129111278928, 6179.5056395489155, 6186.938130618636, 6193.969030154821, 6196.1015652731, 6299.937000629935, 6300.9684951574945, 6310.400511951358, 6320.735852829361, 6325.399087086719, 6167.629942203482, 6169.413905678954, 6174.413430724074, 6175.382461753788, 6186.907196391968], "unit": "score", "name": "prototype.html", "value": 4698.639087978601}, {"lowerIsBetter": false, "replicates": [819.135811718637, 824.9298809601183, 831.9958400207998, 851.6295411495998, 888.409207876762, 12576.056795740322, 12716.554920577782, 12731.745365092704, 12734.745305093904, 12778.61664150077, 11687.5909343173, 11958.402079896014, 11990.760184796321, 12002.0, 12021.879781202208, 653.9509536784748, 807.8990126234221, 822.1203312455675, 823.4853216739538, 824.1675907333606, 798.9720359787409, 806.568485860065, 806.9636866341028, 807.0114110214998, 816.3550794872074, 697.3235961117708, 704.2957042957042, 847.9576021198947, 853.1212850763692, 854.4830377621543, 837.7947402886301, 844.6579135450153, 847.5677404523738, 849.0405841399179, 849.9447535910177, 624.709510077816, 630.4326106504183, 631.0030152359261, 631.3844002097964, 631.8483563944666, 12374.195677280948, 12397.938010309981, 12399.194052386567, 12401.069919755964, 12409.62771116868, 12252.754944901051, 12358.0, 12668.619941401772, 12873.420696068699, 13246.139000965002, 10288.331258468175, 10373.636922707668, 10431.217658675554, 10944.671659850217, 11026.0, 3576.624454432273, 3639.47227651989, 3656.140806910374, 3737.495438115847, 3738.2336620992905, 48551.75724121392, 49981.750091249676, 50045.497725113964, 50067.74966125146, 50431.747841260556, 9552.61789528425, 9596.472194029395, 9726.805463890683, 9746.171575416169, 9965.80068398628, 16348.34606615722, 16349.264283107288, 16417.753733694004, 16443.58891027734, 16444.506664800076, 7153.678084486107, 7268.854622907618, 7355.742549010759, 7405.7778266652085, 7506.43701722373, 4183.163367326547, 4234.724742891703, 4243.384709217146, 4252.617264446215, 4267.850625228102, 3059.128148477673, 3075.8769649214228, 3076.1540576341235, 3085.2132706160232, 3089.2431354318337, 541.4801790281374, 553.2006250967314, 556.3101753825308, 559.1500918603699, 564.9491545760901, 545.0624925128773, 564.3876394112352, 575.6833741442274, 637.6715991264502, 672.2057740498907, 8359.916400836035, 9205.585748641193, 9232.630694772133, 9707.271954603433, 9757.219422446187, 503.4965034965035, 611.2970084402972, 693.5110746923407, 698.8392669686001, 751.4138971602159, 3905.433712111728, 3975.602439756059, 4194.2450358935685, 4206.26390381682, 4231.217224813419, 54112.45887541074, 54136.0, 54407.0, 54548.0, 54724.0, 48725.51274487281, 49023.0, 49216.26175607297, 50763.23855142176, 51298.0, 45710.42895710402, 46320.0, 46389.7680511602, 47571.0, 48067.75966120147, 8654.264387526879, 8725.869111963199, 8755.25580325654, 8785.648574057223, 8915.153060459246, 33518.0, 33839.49240761341, 34270.31459370749, 34545.13637159091, 34854.82572587121, 40252.79873600613, 40473.39289910595, 42658.78670606751, 43033.56966430421, 43563.78218108889, 11331.886681133083, 11355.943220283845, 11422.543098276308, 11788.29270243788, 11807.468663909973, 12185.329806860353, 12642.747145057232, 12793.29636869981, 13027.739445210853, 13029.348532573524, 11415.60045398407, 11676.766464670829, 11718.648440546796, 11756.35340056271, 12058.698532536757, 10785.676429707122, 11026.944865275944, 11239.157063220127, 11405.657830265105, 11524.654260372203, 10891.618793342195, 11213.439328033728, 11356.54573817038, 11615.128865334964, 11618.419079046183, 9515.714528564155, 9717.12545870875, 9811.362261452983, 9816.460094694861, 9931.57806141138, 8817.691380801642, 9112.271018318652, 9281.953590232006, 9699.5150242489, 9765.462899540593], "unit": "score", "name": "yui.html", "value": 6238.854149974381}], "name": "dromaeo_css", "value": 6638.346840635029}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 105.0, 108.0, 111.0, 110.0, 110.0, 110.0, 104.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [151.0, 134.0, 153.0, 161.0, 125.0, 146.0, 161.0, 130.0, 171.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 127.0, 89.0, 72.0, 74.0, 71.0, 108.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 136.0, 96.0, 95.0, 96.0, 143.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 108.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 63.0, 56.0, 56.0, 55.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 80.0, 82.0, 81.0, 81.0, 81.0, 82.0, 82.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [114.0, 116.0, 115.0, 114.0, 119.0, 121.0, 117.0, 124.0, 114.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [144.0, 148.0, 146.0, 141.0, 144.0, 132.0, 144.0, 141.0, 142.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 67.0, 65.0, 65.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1495.1000000000004}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.8335001668335], "unit": "score", "name": "Richards", "value": 211.6001880000001}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [278.8622420524261], "unit": "score", "name": "Encrypt", "value": 954.525066}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [42833.333333333336], "unit": "score", "name": "RegExp", "value": 21.268132295719834}, {"lowerIsBetter": false, "replicates": [582.0721769499418], "unit": "score", "name": "Splay", "value": 140.001538}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18999.591505476754}]} 04:51:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "18999.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1495.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6638.35"}}} 04:51:33 INFO - Return code: 0 04:51:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:33 INFO - # TBPL SUCCESS # 04:51:33 INFO - Running post-action listener: _resource_record_post_action 04:51:33 INFO - Running post-run listener: _resource_record_post_run 04:51:34 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 316936192; Read time: 36; Write time: 192116 04:51:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 19992576; Read time: 0; Write time: 9112 04:51:34 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 296943616; Read time: 36; Write time: 183004 04:51:34 INFO - Running post-run listener: _upload_blobber_files 04:51:34 INFO - Blob upload gear active. 04:51:34 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:51: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 04:51: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', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:51: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 Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:51:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:35 INFO - (blobuploader) - INFO - Done attempting. 04:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:36 INFO - (blobuploader) - INFO - Done attempting. 04:51:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:36 INFO - Return code: 0 04:51:36 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:51:36 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5246683110353b150d6f3e27c4abe628a856fe10eef4f627f8c43f2326b87c99c240b5c553a9d7d44204ec541613df9fad67aa351bc40a4a8482a78ba3e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719ebcbc58633b93cbf7e4c47c293f561d03f94abada405afdecd9f5fc00d5adad6355f00aca27cdd4a7994affb62f1febd499e05dd6a4649b850dac62f4e53b"} 04:51:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:51:36 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:51:36 INFO - Contents: 04:51:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5246683110353b150d6f3e27c4abe628a856fe10eef4f627f8c43f2326b87c99c240b5c553a9d7d44204ec541613df9fad67aa351bc40a4a8482a78ba3e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719ebcbc58633b93cbf7e4c47c293f561d03f94abada405afdecd9f5fc00d5adad6355f00aca27cdd4a7994affb62f1febd499e05dd6a4649b850dac62f4e53b"} 04:51:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:36 INFO - Copying logs to upload dir... 04:51:36 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:51:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.380174 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-01-18 04:51:36.242430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 04:51:36.245777) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5246683110353b150d6f3e27c4abe628a856fe10eef4f627f8c43f2326b87c99c240b5c553a9d7d44204ec541613df9fad67aa351bc40a4a8482a78ba3e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719ebcbc58633b93cbf7e4c47c293f561d03f94abada405afdecd9f5fc00d5adad6355f00aca27cdd4a7994affb62f1febd499e05dd6a4649b850dac62f4e53b"} build_url:https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/JfIALUL7TVqp2hl-8TGVYw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32f5246683110353b150d6f3e27c4abe628a856fe10eef4f627f8c43f2326b87c99c240b5c553a9d7d44204ec541613df9fad67aa351bc40a4a8482a78ba3e14", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/719ebcbc58633b93cbf7e4c47c293f561d03f94abada405afdecd9f5fc00d5adad6355f00aca27cdd4a7994affb62f1febd499e05dd6a4649b850dac62f4e53b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-18 04:51:36.273001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:51:36.273735) ========= 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=8887e36bb8e381bfd44124ac000001a8-1453116212.531757-1582919400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004627 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-18 04:51:36.355647) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 04:51:36.355993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-18 04:51:36.356413) ========= ========= Total master_lag: 0.28 =========