builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1451047229.05 results: success (0) buildid: 20151225023001 builduid: 2579f8d884fb4031b39331e9a7fe6284 revision: e61c31bf49237a13b7ccf0b7f59e06112009bb38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.054663) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.055163) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.055534) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.087541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.087876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.139651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.139943) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.188922) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.189195) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.189557) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.189837) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 04:40:32-- 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% 40.3M=0s 2015-12-25 04:40:33 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164000 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.366012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.366313) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019136 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.416015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.416397) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e61c31bf49237a13b7ccf0b7f59e06112009bb38 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e61c31bf49237a13b7ccf0b7f59e06112009bb38 --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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 04:40:33,195 truncating revision to first 12 chars 2015-12-25 04:40:33,195 Setting DEBUG logging. 2015-12-25 04:40:33,195 attempt 1/10 2015-12-25 04:40:33,195 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e61c31bf4923?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 04:40:33,417 unpacking tar archive at: b2g-inbound-e61c31bf4923/testing/mozharness/ program finished with exit code 0 elapsedTime=0.480251 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.913687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.913982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.924394) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.924790) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 04:40:29.925362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 04:40:29.925661) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:40:33 INFO - MultiFileLogger online at 20151225 04:40:33 in /builds/slave/test-pgo 04:40:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 04:40:33 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:40:33 INFO - {'append_to_log': False, 04:40:33 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:40:33 INFO - 'blob_upload_branch': 'B2G-Inbound', 04:40:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:40:33 INFO - 'branch': 'B2G-Inbound', 04:40:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:33 INFO - 'config_files': ('talos/linux_config.py',), 04:40:33 INFO - 'default_actions': ('clobber', 04:40:33 INFO - 'read-buildbot-config', 04:40:33 INFO - 'download-and-extract', 04:40:33 INFO - 'populate-webroot', 04:40:33 INFO - 'create-virtualenv', 04:40:33 INFO - 'install', 04:40:33 INFO - 'run-tests'), 04:40:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:33 INFO - 'download_minidump_stackwalk': True, 04:40:33 INFO - 'download_symbols': 'ondemand', 04:40:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:33 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:33 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:33 INFO - 'installer_path': 'installer.exe', 04:40:33 INFO - 'log_level': 'info', 04:40:33 INFO - 'log_name': 'talos', 04:40:33 INFO - 'log_to_console': True, 04:40:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:40:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:40:33 INFO - 'opt_config_files': (), 04:40:33 INFO - 'pip_index': False, 04:40:33 INFO - 'sps_profile': False, 04:40:33 INFO - 'sps_profile_interval': 0, 04:40:33 INFO - 'suite': 'dromaeojs', 04:40:33 INFO - 'system_bits': '64', 04:40:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:33 INFO - 'title': 'talos-linux64-ix-056', 04:40:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:33 INFO - 'use_talos_json': True, 04:40:33 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:40:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:33 INFO - 'work_dir': 'build'} 04:40:33 INFO - ##### 04:40:33 INFO - ##### Running clobber step. 04:40:33 INFO - ##### 04:40:33 INFO - Running pre-action listener: _resource_record_pre_action 04:40:33 INFO - Running main action method: clobber 04:40:33 INFO - rmtree: /builds/slave/test-pgo/build 04:40:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 04:40:34 INFO - Running post-action listener: _resource_record_post_action 04:40:34 INFO - ##### 04:40:34 INFO - ##### Running read-buildbot-config step. 04:40:34 INFO - ##### 04:40:34 INFO - Running pre-action listener: _resource_record_pre_action 04:40:34 INFO - Running main action method: read_buildbot_config 04:40:34 INFO - Using buildbot properties: 04:40:34 INFO - { 04:40:34 INFO - "project": "", 04:40:34 INFO - "product": "firefox", 04:40:34 INFO - "script_repo_revision": "production", 04:40:34 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 04:40:34 INFO - "repository": "", 04:40:34 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 04:40:34 INFO - "buildid": "20151225023001", 04:40:34 INFO - "pgo_build": "True", 04:40:34 INFO - "basedir": "/builds/slave/test-pgo", 04:40:34 INFO - "buildnumber": 154, 04:40:34 INFO - "slavename": "talos-linux64-ix-056", 04:40:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:40:34 INFO - "platform": "ubuntu64_hw", 04:40:34 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 04:40:34 INFO - "branch": "b2g-inbound", 04:40:34 INFO - "repo_path": "integration/b2g-inbound", 04:40:34 INFO - "revision": "e61c31bf49237a13b7ccf0b7f59e06112009bb38", 04:40:34 INFO - "stage_platform": "linux64-pgo", 04:40:34 INFO - "builduid": "2579f8d884fb4031b39331e9a7fe6284", 04:40:34 INFO - "slavebuilddir": "test" 04:40:34 INFO - } 04:40:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:40:34 INFO - Running post-action listener: _resource_record_post_action 04:40:34 INFO - ##### 04:40:34 INFO - ##### Running download-and-extract step. 04:40:34 INFO - ##### 04:40:34 INFO - Running pre-action listener: _resource_record_pre_action 04:40:34 INFO - Running main action method: download_and_extract 04:40:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:34 INFO - https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:40:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/test_packages.json 04:40:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/test_packages.json 04:40:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:40:34 INFO - Downloaded 1302 bytes. 04:40:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:40:34 INFO - Using the following test package requirements: 04:40:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:40:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'jsshell-linux-x86_64.zip'], 04:40:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:40:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:40:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:40:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:40:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:40:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:40:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:40:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:40:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:34 INFO - https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:36 INFO - Downloaded 23180385 bytes. 04:40:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:40:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:40:37 INFO - Return code: 0 04:40:37 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:40:37 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:40:37 INFO - https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:40:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:38 INFO - Downloaded 23180385 bytes. 04:40:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:40:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:40:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:40:39 INFO - Return code: 0 04:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:39 INFO - https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:41 INFO - Downloaded 11132277 bytes. 04:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:40:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:40:41 INFO - Return code: 0 04:40: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:40:41 INFO - https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:40:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AMtv5F_RR-qP7TQW8nKzkw/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:40:43 INFO - Downloaded 54839637 bytes. 04:40:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - mkdir: /builds/slave/test-pgo/properties 04:40:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:40:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:40:43 INFO - Contents: 04:40:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:40:43 INFO - Running post-action listener: _resource_record_post_action 04:40:43 INFO - Running post-action listener: set_extra_try_arguments 04:40:43 INFO - ##### 04:40:43 INFO - ##### Running populate-webroot step. 04:40:43 INFO - ##### 04:40:43 INFO - Running pre-action listener: _resource_record_pre_action 04:40:43 INFO - Running main action method: populate_webroot 04:40:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:40:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:40:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:40:43 INFO - '--tppagecycles', 04:40:43 INFO - '7'], 04:40:43 INFO - 'tests': ['tsvgm']}}, 04:40:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:40:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:40:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:40:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:40:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'tests': ['damp', 'tps']}, 04:40:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['damp', 'tps']}, 04:40:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:40:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:40:43 INFO - 'other': {'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'other_l64': {'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'other_nol64': {'tests': ['a11yr', 04:40:43 INFO - 'ts_paint', 04:40:43 INFO - 'tpaint', 04:40:43 INFO - 'sessionrestore', 04:40:43 INFO - 'sessionrestore_no_auto_restore']}, 04:40:43 INFO - 'svgr': {'tests': ['tsvgx', 04:40:43 INFO - 'tsvgr_opacity', 04:40:43 INFO - 'tart', 04:40:43 INFO - 'tscrollx', 04:40:43 INFO - 'cart']}, 04:40:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['tsvgx', 04:40:43 INFO - 'tsvgr_opacity', 04:40:43 INFO - 'tart', 04:40:43 INFO - 'tscrollx', 04:40:43 INFO - 'cart']}, 04:40:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'tests': ['tp5o']}, 04:40:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'talos_options': ['--e10s'], 04:40:43 INFO - 'tests': ['tp5o']}, 04:40:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'talos_options': ['--xperf_path', 04:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:43 INFO - 'tests': ['tp5n']}, 04:40:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:40:43 INFO - 'talos_options': ['--e10s', 04:40:43 INFO - '--xperf_path', 04:40:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:40:43 INFO - 'tests': ['tp5n']}}, 04:40:43 INFO - 'talos.zip': {'path': '', 04:40:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:40:43 INFO - Running post-action listener: _resource_record_post_action 04:40:43 INFO - ##### 04:40:43 INFO - ##### Running create-virtualenv step. 04:40:43 INFO - ##### 04:40:43 INFO - Running pre-action listener: _resource_record_pre_action 04:40:43 INFO - Running main action method: create_virtualenv 04:40:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:40:43 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:40:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:40:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:40:43 INFO - Using real prefix '/usr' 04:40:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:40:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:40:45 INFO - Installing pip.................done. 04:40:45 INFO - Return code: 0 04:40:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40:45 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:40:45 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:40:45 INFO - Using env: {'DISPLAY': ':0', 04:40:45 INFO - 'HOME': '/home/cltbld', 04:40:45 INFO - 'LANG': 'en_US.UTF-8', 04:40:45 INFO - 'LANGUAGE': 'en_US:en', 04:40:45 INFO - 'LOGNAME': 'cltbld', 04:40:45 INFO - 'MAIL': '/var/mail/cltbld', 04:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:45 INFO - 'MOZ_NO_REMOTE': '1', 04:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:45 INFO - 'NO_EM_RESTART': '1', 04:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:45 INFO - 'SHELL': '/bin/bash', 04:40:45 INFO - 'SHLVL': '1', 04:40:45 INFO - 'TERM': 'linux', 04:40:45 INFO - 'TMOUT': '86400', 04:40:45 INFO - 'USER': 'cltbld', 04:40:45 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:45 INFO - '_': '/tools/buildbot/bin/python'} 04:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:45 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:40:45 INFO - Cleaning up... 04:40:45 INFO - Return code: 0 04:40:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:45 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40:45 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:40:45 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:40:45 INFO - Using env: {'DISPLAY': ':0', 04:40:45 INFO - 'HOME': '/home/cltbld', 04:40:45 INFO - 'LANG': 'en_US.UTF-8', 04:40:45 INFO - 'LANGUAGE': 'en_US:en', 04:40:45 INFO - 'LOGNAME': 'cltbld', 04:40:45 INFO - 'MAIL': '/var/mail/cltbld', 04:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:45 INFO - 'MOZ_NO_REMOTE': '1', 04:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:45 INFO - 'NO_EM_RESTART': '1', 04:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:45 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:45 INFO - 'SHELL': '/bin/bash', 04:40:45 INFO - 'SHLVL': '1', 04:40:45 INFO - 'TERM': 'linux', 04:40:45 INFO - 'TMOUT': '86400', 04:40:45 INFO - 'USER': 'cltbld', 04:40:45 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:45 INFO - '_': '/tools/buildbot/bin/python'} 04:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:46 INFO - Downloading/unpacking psutil>=0.7.1 04:40: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:40: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:40: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:40: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:40: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:40: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:40:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:40:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:40:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:47 INFO - Installing collected packages: psutil 04:40:47 INFO - Running setup.py install for psutil 04:40:48 INFO - building 'psutil._psutil_linux' extension 04:40:48 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:40:48 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:40:48 INFO - building 'psutil._psutil_posix' extension 04:40:48 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:40:48 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:40:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:40:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:40:48 INFO - Successfully installed psutil 04:40:48 INFO - Cleaning up... 04:40:48 INFO - Return code: 0 04:40:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:40: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:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40: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', '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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 04:40: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 mozsystemmonitor==0.0.0 04:40:48 INFO - Using env: {'DISPLAY': ':0', 04:40:48 INFO - 'HOME': '/home/cltbld', 04:40:48 INFO - 'LANG': 'en_US.UTF-8', 04:40:48 INFO - 'LANGUAGE': 'en_US:en', 04:40:48 INFO - 'LOGNAME': 'cltbld', 04:40:48 INFO - 'MAIL': '/var/mail/cltbld', 04:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:48 INFO - 'MOZ_NO_REMOTE': '1', 04:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:48 INFO - 'NO_EM_RESTART': '1', 04:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:48 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:48 INFO - 'SHELL': '/bin/bash', 04:40:48 INFO - 'SHLVL': '1', 04:40:48 INFO - 'TERM': 'linux', 04:40:48 INFO - 'TMOUT': '86400', 04:40:48 INFO - 'USER': 'cltbld', 04:40:48 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:48 INFO - '_': '/tools/buildbot/bin/python'} 04:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:40: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:40: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:40: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:40: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:40: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:40: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:40:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:40:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:40:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:40:50 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:40:50 INFO - Installing collected packages: mozsystemmonitor 04:40:50 INFO - Running setup.py install for mozsystemmonitor 04:40:50 INFO - Successfully installed mozsystemmonitor 04:40:50 INFO - Cleaning up... 04:40:50 INFO - Return code: 0 04:40:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:40:50 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:40:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:50 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:40:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:50 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40:50 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:40:50 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:40:50 INFO - Using env: {'DISPLAY': ':0', 04:40:50 INFO - 'HOME': '/home/cltbld', 04:40:50 INFO - 'LANG': 'en_US.UTF-8', 04:40:50 INFO - 'LANGUAGE': 'en_US:en', 04:40:50 INFO - 'LOGNAME': 'cltbld', 04:40:50 INFO - 'MAIL': '/var/mail/cltbld', 04:40:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:50 INFO - 'MOZ_NO_REMOTE': '1', 04:40:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:50 INFO - 'NO_EM_RESTART': '1', 04:40:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:50 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:50 INFO - 'SHELL': '/bin/bash', 04:40:50 INFO - 'SHLVL': '1', 04:40:50 INFO - 'TERM': 'linux', 04:40:50 INFO - 'TMOUT': '86400', 04:40:50 INFO - 'USER': 'cltbld', 04:40:50 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:50 INFO - '_': '/tools/buildbot/bin/python'} 04:40:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:40: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:40: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:40: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:40: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:40: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:40: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:40:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:40:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:40:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:40:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 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:40:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:40:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:40:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:40:53 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:40:53 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:40:53 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:40:53 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:40:53 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:40:53 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:40:53 INFO - Downloading docopt-0.6.1.tar.gz 04:40:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:40:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:40:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:40:53 INFO - Running setup.py install for blobuploader 04:40:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:40:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:40:53 INFO - Running setup.py install for requests 04:40:53 INFO - Running setup.py install for docopt 04:40:53 INFO - Successfully installed blobuploader requests docopt 04:40:53 INFO - Cleaning up... 04:40:53 INFO - Return code: 0 04:40:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:40:53 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:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:53 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:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:53 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40:53 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:40:53 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:40:53 INFO - Using env: {'DISPLAY': ':0', 04:40:53 INFO - 'HOME': '/home/cltbld', 04:40:53 INFO - 'LANG': 'en_US.UTF-8', 04:40:53 INFO - 'LANGUAGE': 'en_US:en', 04:40:53 INFO - 'LOGNAME': 'cltbld', 04:40:53 INFO - 'MAIL': '/var/mail/cltbld', 04:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:53 INFO - 'MOZ_NO_REMOTE': '1', 04:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:53 INFO - 'NO_EM_RESTART': '1', 04:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:53 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:53 INFO - 'SHELL': '/bin/bash', 04:40:53 INFO - 'SHLVL': '1', 04:40:53 INFO - 'TERM': 'linux', 04:40:53 INFO - 'TMOUT': '86400', 04:40:53 INFO - 'USER': 'cltbld', 04:40:53 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:53 INFO - '_': '/tools/buildbot/bin/python'} 04:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:40:54 INFO - Running setup.py (path:/tmp/pip-9yztqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:40:54 INFO - Running setup.py (path:/tmp/pip-NQsurA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:40:54 INFO - Running setup.py (path:/tmp/pip-lqiNUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:40:54 INFO - Running setup.py (path:/tmp/pip-uRxCoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:40:54 INFO - Running setup.py (path:/tmp/pip-jxVPmH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:40:54 INFO - Running setup.py (path:/tmp/pip-ZJKYbF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:40:54 INFO - Running setup.py (path:/tmp/pip-BwAx7g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:40:54 INFO - Running setup.py (path:/tmp/pip-kOSA8H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:40:54 INFO - Running setup.py (path:/tmp/pip-aVrdyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:40:54 INFO - Running setup.py (path:/tmp/pip-LqOOCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:40:54 INFO - Running setup.py (path:/tmp/pip-_kFJ7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:40:54 INFO - Running setup.py (path:/tmp/pip-3_AZCt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:40:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:40:54 INFO - Running setup.py (path:/tmp/pip-mf7R8F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:40:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:40:55 INFO - Running setup.py (path:/tmp/pip-AOj57y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:40:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:40:55 INFO - Running setup.py (path:/tmp/pip-KNAQpW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:40:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:40:55 INFO - Running setup.py (path:/tmp/pip-W7mcPI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:40:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:40:55 INFO - Running setup.py (path:/tmp/pip-SVmK_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:40:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:40:55 INFO - Running setup.py install for manifestparser 04:40:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:40:55 INFO - Running setup.py install for mozcrash 04:40:55 INFO - Running setup.py install for mozdebug 04:40:55 INFO - Running setup.py install for mozdevice 04:40:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:40:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:40:55 INFO - Running setup.py install for mozfile 04:40:55 INFO - Running setup.py install for mozhttpd 04:40:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:40:55 INFO - Running setup.py install for mozinfo 04:40:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for mozInstall 04:40:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for mozleak 04:40:56 INFO - Running setup.py install for mozlog 04:40:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for moznetwork 04:40:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for mozprocess 04:40:56 INFO - Running setup.py install for mozprofile 04:40:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for mozrunner 04:40:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:40:56 INFO - Running setup.py install for mozscreenshot 04:40:56 INFO - Running setup.py install for moztest 04:40:56 INFO - Running setup.py install for mozversion 04:40:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:40:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:40:57 INFO - Cleaning up... 04:40:57 INFO - Return code: 0 04:40:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:40:57 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:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:57 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:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:40:57 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:40:57 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:40:57 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:40:57 INFO - Using env: {'DISPLAY': ':0', 04:40:57 INFO - 'HOME': '/home/cltbld', 04:40:57 INFO - 'LANG': 'en_US.UTF-8', 04:40:57 INFO - 'LANGUAGE': 'en_US:en', 04:40:57 INFO - 'LOGNAME': 'cltbld', 04:40:57 INFO - 'MAIL': '/var/mail/cltbld', 04:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:40:57 INFO - 'MOZ_NO_REMOTE': '1', 04:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:40:57 INFO - 'NO_EM_RESTART': '1', 04:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:40:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:40:57 INFO - 'SHELL': '/bin/bash', 04:40:57 INFO - 'SHLVL': '1', 04:40:57 INFO - 'TERM': 'linux', 04:40:57 INFO - 'TMOUT': '86400', 04:40:57 INFO - 'USER': 'cltbld', 04:40:57 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:40:57 INFO - '_': '/tools/buildbot/bin/python'} 04:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:40:57 INFO - Running setup.py (path:/tmp/pip-jAuG0e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:40:57 INFO - Running setup.py (path:/tmp/pip-p8rQab-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:40:57 INFO - Running setup.py (path:/tmp/pip-vqfgm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:40:57 INFO - Running setup.py (path:/tmp/pip-6mcRfu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:40:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:40:57 INFO - Running setup.py (path:/tmp/pip-zfUmu5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:40:57 INFO - Running setup.py (path:/tmp/pip-raMV2u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:40:57 INFO - Running setup.py (path:/tmp/pip-HjSA2o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:40:57 INFO - Running setup.py (path:/tmp/pip-kc4VtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:40:57 INFO - Running setup.py (path:/tmp/pip-EHJxpf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:40:57 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:40:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:40:57 INFO - Running setup.py (path:/tmp/pip-7SgH02-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:40:58 INFO - Running setup.py (path:/tmp/pip-SBAHwE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:40:58 INFO - Running setup.py (path:/tmp/pip-m6KLLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:40:58 INFO - Running setup.py (path:/tmp/pip-A99nnl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:40:58 INFO - Running setup.py (path:/tmp/pip-k6dHNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:40:58 INFO - Running setup.py (path:/tmp/pip-jpfiQG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:40:58 INFO - Running setup.py (path:/tmp/pip-4nRdpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:40:58 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:40:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:40:58 INFO - Running setup.py (path:/tmp/pip-D8MaXb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:40:58 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:40:58 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:40:58 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:40:58 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:40: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 mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:40:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:40:58 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:40:58 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:40:58 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:40:58 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:40:58 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:40:58 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:41:00 INFO - Downloading blessings-1.5.1.tar.gz 04:41:00 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:41:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:00 INFO - Installing collected packages: blessings 04:41:00 INFO - Running setup.py install for blessings 04:41:00 INFO - Successfully installed blessings 04:41:00 INFO - Cleaning up... 04:41:00 INFO - Return code: 0 04:41:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:41:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:41:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:41:00 INFO - Reading from file tmpfile_stdout 04:41:00 INFO - Current package versions: 04:41:00 INFO - argparse == 1.2.1 04:41:00 INFO - blessings == 1.5.1 04:41:00 INFO - blobuploader == 1.2.4 04:41:00 INFO - docopt == 0.6.1 04:41:00 INFO - manifestparser == 1.1 04:41:00 INFO - mozInstall == 1.12 04:41:00 INFO - mozcrash == 0.16 04:41:00 INFO - mozdebug == 0.1 04:41:00 INFO - mozdevice == 0.47 04:41:00 INFO - mozfile == 1.2 04:41:00 INFO - mozhttpd == 0.7 04:41:00 INFO - mozinfo == 0.9 04:41:00 INFO - mozleak == 0.1 04:41:00 INFO - mozlog == 3.1 04:41:00 INFO - moznetwork == 0.27 04:41:00 INFO - mozprocess == 0.22 04:41:00 INFO - mozprofile == 0.28 04:41:00 INFO - mozrunner == 6.11 04:41:00 INFO - mozscreenshot == 0.1 04:41:00 INFO - mozsystemmonitor == 0.0 04:41:00 INFO - moztest == 0.7 04:41:00 INFO - mozversion == 1.4 04:41:00 INFO - psutil == 3.1.1 04:41:00 INFO - requests == 1.2.3 04:41:00 INFO - wsgiref == 0.1.2 04:41:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:41:00 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:41:00 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:41:00 INFO - Using env: {'DISPLAY': ':0', 04:41:00 INFO - 'HOME': '/home/cltbld', 04:41:00 INFO - 'LANG': 'en_US.UTF-8', 04:41:00 INFO - 'LANGUAGE': 'en_US:en', 04:41:00 INFO - 'LOGNAME': 'cltbld', 04:41:00 INFO - 'MAIL': '/var/mail/cltbld', 04:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:00 INFO - 'MOZ_NO_REMOTE': '1', 04:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:00 INFO - 'NO_EM_RESTART': '1', 04:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:41:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:41:00 INFO - 'SHELL': '/bin/bash', 04:41:00 INFO - 'SHLVL': '1', 04:41:00 INFO - 'TERM': 'linux', 04:41:00 INFO - 'TMOUT': '86400', 04:41:00 INFO - 'USER': 'cltbld', 04:41:00 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:00 INFO - '_': '/tools/buildbot/bin/python'} 04:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 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:41:00 INFO - Cleaning up... 04:41:00 INFO - Return code: 0 04:41:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:41:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 04:41:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:41:00 INFO - Using env: {'DISPLAY': ':0', 04:41:00 INFO - 'HOME': '/home/cltbld', 04:41:00 INFO - 'LANG': 'en_US.UTF-8', 04:41:00 INFO - 'LANGUAGE': 'en_US:en', 04:41:00 INFO - 'LOGNAME': 'cltbld', 04:41:00 INFO - 'MAIL': '/var/mail/cltbld', 04:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:00 INFO - 'MOZ_NO_REMOTE': '1', 04:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:00 INFO - 'NO_EM_RESTART': '1', 04:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:41:00 INFO - 'PWD': '/builds/slave/test-pgo', 04:41:00 INFO - 'SHELL': '/bin/bash', 04:41:00 INFO - 'SHLVL': '1', 04:41:00 INFO - 'TERM': 'linux', 04:41:00 INFO - 'TMOUT': '86400', 04:41:00 INFO - 'USER': 'cltbld', 04:41:00 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:00 INFO - '_': '/tools/buildbot/bin/python'} 04:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:01 INFO - Downloading/unpacking jsonschema 04:41: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:41: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:41: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:41: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:41: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:41: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:41:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:41:03 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:41:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:41: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:41: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:41: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:41: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:41: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:41: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:41:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:41:03 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:41:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:41:03 INFO - warning: no files found matching '*.txt' 04:41:03 INFO - no previously-included directories found matching 'build' 04:41:03 INFO - no previously-included directories found matching 'dist' 04:41:03 INFO - no previously-included directories found matching '.git*' 04:41:03 INFO - Installing collected packages: jsonschema, functools32 04:41:03 INFO - Running setup.py install for functools32 04:41:03 INFO - warning: no files found matching '*.txt' 04:41:03 INFO - no previously-included directories found matching 'build' 04:41:03 INFO - no previously-included directories found matching 'dist' 04:41:03 INFO - no previously-included directories found matching '.git*' 04:41:03 INFO - Successfully installed jsonschema functools32 04:41:03 INFO - Cleaning up... 04:41:03 INFO - Return code: 0 04:41:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:03 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 0x7f37e344bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2176630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, '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': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', '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:41:03 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:41:03 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:41:03 INFO - Using env: {'DISPLAY': ':0', 04:41:03 INFO - 'HOME': '/home/cltbld', 04:41:03 INFO - 'LANG': 'en_US.UTF-8', 04:41:03 INFO - 'LANGUAGE': 'en_US:en', 04:41:03 INFO - 'LOGNAME': 'cltbld', 04:41:03 INFO - 'MAIL': '/var/mail/cltbld', 04:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:03 INFO - 'MOZ_NO_REMOTE': '1', 04:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:03 INFO - 'NO_EM_RESTART': '1', 04:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:41:03 INFO - 'PWD': '/builds/slave/test-pgo', 04:41:03 INFO - 'SHELL': '/bin/bash', 04:41:03 INFO - 'SHLVL': '1', 04:41:03 INFO - 'TERM': 'linux', 04:41:03 INFO - 'TMOUT': '86400', 04:41:03 INFO - 'USER': 'cltbld', 04:41:03 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:03 INFO - '_': '/tools/buildbot/bin/python'} 04:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:03 INFO - Downloading/unpacking flake8 04:41: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:41: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:41: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:41: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:41: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:41: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:41:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:41:05 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:41:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:41:05 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:41:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 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:41:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:41:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:06 INFO - no previously-included directories found matching 'docs/_build' 04:41:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:41:06 INFO - Running setup.py install for pep8 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:41:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:41:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:41:06 INFO - no previously-included directories found matching 'docs/_build' 04:41:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:41:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:41:06 INFO - Cleaning up... 04:41:06 INFO - Return code: 0 04:41:06 INFO - Running post-action listener: _resource_record_post_action 04:41:06 INFO - Running post-action listener: _start_resource_monitoring 04:41:06 INFO - Starting resource monitoring. 04:41:06 INFO - ##### 04:41:06 INFO - ##### Running install step. 04:41:06 INFO - ##### 04:41:06 INFO - Running pre-action listener: _resource_record_pre_action 04:41:06 INFO - Running main action method: install 04:41:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:41:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:41:06 INFO - Reading from file tmpfile_stdout 04:41:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:41:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:41:06 INFO - Reading from file tmpfile_stdout 04:41:06 INFO - Output received: 04:41:06 INFO - Usage: mozinstall [options] installer 04:41:06 INFO - Options: 04:41:06 INFO - -h, --help show this help message and exit 04:41:06 INFO - -d DEST, --destination=DEST 04:41:06 INFO - Directory to install application into. [default: 04:41:06 INFO - "/builds/slave/test-pgo"] 04:41:06 INFO - --app=APP Application being installed. [default: firefox] 04:41:06 INFO - mkdir: /builds/slave/test-pgo/build/application 04:41:06 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:41:06 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:41:22 INFO - Reading from file tmpfile_stdout 04:41:22 INFO - Output received: 04:41:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:41:22 INFO - Running post-action listener: _resource_record_post_action 04:41:22 INFO - ##### 04:41:22 INFO - ##### Running run-tests step. 04:41:22 INFO - ##### 04:41:22 INFO - Running pre-action listener: _resource_record_pre_action 04:41:22 INFO - Running main action method: run_tests 04:41:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:41:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:41:22 INFO - Python 2.7.3 04:41:22 INFO - Return code: 0 04:41:22 INFO - grabbing minidump binary from tooltool 04:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:22 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 0x2207840>, '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 0x21746b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2174b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:41:22 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:41:22 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:41:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:41:22 INFO - Return code: 0 04:41:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:41:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:41:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:41:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:41:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:41:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:41:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:41:23 INFO - Return code: 0 04:41:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:41:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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:41:23 INFO - Using env: {'DISPLAY': ':0', 04:41:23 INFO - 'HOME': '/home/cltbld', 04:41:23 INFO - 'LANG': 'en_US.UTF-8', 04:41:23 INFO - 'LANGUAGE': 'en_US:en', 04:41:23 INFO - 'LOGNAME': 'cltbld', 04:41:23 INFO - 'MAIL': '/var/mail/cltbld', 04:41:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:41:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:23 INFO - 'MOZ_NO_REMOTE': '1', 04:41:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:41:23 INFO - 'NO_EM_RESTART': '1', 04:41:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:41:23 INFO - 'PWD': '/builds/slave/test-pgo', 04:41:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:41:23 INFO - 'SHELL': '/bin/bash', 04:41:23 INFO - 'SHLVL': '1', 04:41:23 INFO - 'TERM': 'linux', 04:41:23 INFO - 'TMOUT': '86400', 04:41:23 INFO - 'USER': 'cltbld', 04:41:23 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652', 04:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:23 INFO - '_': '/tools/buildbot/bin/python'} 04:41:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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:41:24 INFO - mozversion application_buildid: 20151225023001 04:41:24 INFO - mozversion application_changeset: e61c31bf49237a13b7ccf0b7f59e06112009bb38 04:41:24 INFO - mozversion application_display_name: Nightly 04:41:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:41:24 INFO - mozversion application_name: Firefox 04:41:24 INFO - mozversion application_remotingname: firefox 04:41:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 04:41:24 INFO - mozversion application_vendor: Mozilla 04:41:24 INFO - mozversion application_version: 46.0a1 04:41:24 INFO - mozversion platform_buildid: 20151225023001 04:41:24 INFO - mozversion platform_changeset: e61c31bf49237a13b7ccf0b7f59e06112009bb38 04:41:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 04:41:24 INFO - mozversion platform_version: 46.0a1 04:41:24 INFO - using testdate: 1451047284 04:41:24 INFO - actual date: 1451047284 04:41:24 INFO - starting webserver on 'localhost:41878' 04:41:24 INFO - SUITE-START | Running 3 tests 04:41:24 INFO - TEST-START | dromaeo_css 04:41:24 INFO - operating with platform_type : linux_ 04:41:24 INFO - Initialising browser for dromaeo_css test... 04:41:24 INFO - TEST-INFO | started process 25776 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiLlGfF/profile http://localhost:41878/getInfo.html) 04:41:29 INFO - PROCESS | 25776 | __metrics Screen width/height:1600/1200 04:41:29 INFO - PROCESS | 25776 | colorDepth:24 04:41:29 INFO - PROCESS | 25776 | Browser inner width/height: 1024/697 04:41:29 INFO - PROCESS | 25776 | __metrics 04:41:29 INFO - PROCESS | 25776 | 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:41:29 INFO - PROCESS | 25776 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:30 INFO - TEST-INFO | 25776: exit 0 04:41:30 INFO - Browser initialized. 04:41:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:41:30 INFO - TEST-INFO | started process 25874 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiLlGfF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:42 INFO - PROCESS | 25874 | RSS: Main: 150728704 04:41:42 INFO - PROCESS | 25874 | 04:42:33 INFO - PROCESS | 25874 | 1451047353676 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:44:42 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41878/tests/dromaeo/cssquery-ext.html) 04:44:43 INFO - PROCESS | 25874 | RSS: Main: 266887168 04:44:43 INFO - PROCESS | 25874 | 04:47:46 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-ext.html (next: http://localhost:41878/tests/dromaeo/cssquery-jquery.html) 04:47:46 INFO - PROCESS | 25874 | RSS: Main: 225755136 04:47:46 INFO - PROCESS | 25874 | 04:50:48 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41878/tests/dromaeo/cssquery-mootools.html) 04:50:49 INFO - PROCESS | 25874 | RSS: Main: 219561984 04:50:49 INFO - PROCESS | 25874 | 04:53:51 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41878/tests/dromaeo/cssquery-prototype.html) 04:53:51 INFO - PROCESS | 25874 | RSS: Main: 207917056 04:53:51 INFO - PROCESS | 25874 | 04:56:54 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41878/tests/dromaeo/cssquery-yui.html) 04:56:54 INFO - PROCESS | 25874 | RSS: Main: 213094400 04:56:54 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | Cycle 1(1): loaded http://localhost:41878/tests/dromaeo/cssquery-yui.html (next: http://localhost:41878/tests/dromaeo/cssquery-dojo.html) 04:59:57 INFO - PROCESS | 25874 | RSS: Main: 259923968 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | __start_tp_report 04:59:57 INFO - PROCESS | 25874 | _x_x_mozilla_page_load 04:59:57 INFO - PROCESS | 25874 | _x_x_mozilla_page_load_details 04:59:57 INFO - PROCESS | 25874 | |i|pagename|runs| 04:59:57 INFO - PROCESS | 25874 | |0;dojo.html;3103.8137711737295;3155.731762800162;3201.0396880935727;3204.3110731192787;3227.8708851645933;5182.196759502273;5249.8687532811655;5279.313689220401;5289.814856480024;5352.357717073952;5309.867253318669;5310.123829568126;5354;5378.865528361793;5421.728913554326;4789.473157952622;4812.422509298889;4826.927596086061;4877;4909.7545122743895;4801.90396192076;4890.535399137077;4898.804047838083;4921.753912304388;4985.302057711923;4813.6389770767155;4848.296996935443;4861.052094841507;4872.1473742094995;4917.041176970492;4857.247126695368;4858.902821943541;4861.246506791453;4881.6338774591695;4907.460179380265;4839.080574690797;4839.395075615548;4840.927386089212;4867.537583929557;4881.974785295092;5005.6996580205305;5048.268001139814;5134.229865520165;5151.304573882516;5174.482551744795;5758.2514273144225;5758.309002919635;5760.855978600526;5765.423457654243;5767.36558978512;5573.665580065209;5787;5788.768449262025;5800.506956908668;5800.9709951450395;5243.842684719464;5281.524662780368;5329.81345652908;5365.490278423544;5371.785128594852;5859.472647461749;5874.206982057453;5883;5889.852753681193;5923.7926672566255;5444.074507333763;5626.127950167731;5647.37878833328;5647.576431767634;5673.716314184274;5634.464725851038;5692.459216374438;5725.055365864586;5853.03424934881;5894;5703;5744;5749.8275051748515;5754.251947246915;5754.4533269339345;5580.720963951786;5756.683382414008;5757.596968212185;5759.337676167294;5760.279965004374;4314.633256173198;4365.956340436618;4382.868513944587;4409.647228221735;4420.58004489573;3984.641382275551;3994.4407782910416;4000.899977500586;4020.4773379460485;4036.0313524753847;5423.240746295522;5445.455454454602;5452.945470545323;5458.972705136528;5491.450854914477;5610.635308704921;5676.602637815313;5705.74324155414;5747;5751.051076572402;5303.787848486095;5314.5748340132695;5327.627066105335;5362.1420572708175;5409.891802164014;4889.046635905964;4891.388576427947;4893.657443978887;4905.509449055137;4932.950670493321;5770.105633626795;5911.083782013795;5914.645121292736;5959.493443057302;5962.97018514922;5634.464725851038;5670.829875103754;5685.573581981285;5698.430156984268;5747.97126014384;5945.197398351167;5952.613080149777;5957.225560677258;5959.046552551571;5970.402959703995;5535.114381698909;5632.098864181711;5646.71766411686;5649.971750141387;5685.658860468385;5664.291963504562;5714;5737.9139312911175;5742.885142297214;5801.1878337033695;5669;5690.487856092972;5698.0598201296325;5699.145128230799;5702.37273899879;5338.3593968724;5427.185922111715;5433.8369848904595;5677.290338707661;5679.034564124191;5446.754896029767;5508.531774799027;5515.61390702647;5526.22632831412;5567.3040869891265;5631.183478395692;5659.207710920557;5663.348714897839;5673.489385955284;5694.9179655865255;5321.467853214647;5497.862553436036;5512.724363781875;5519.089350257163;5527.2538207341495 04:59:57 INFO - PROCESS | 25874 | |1;ext.html;576.7614410341129;587.5064945445828;597.7310210405313;606.2391698418484;610.3012051201376;29477.705222947792;37616.62383376169;37951;38177.618223817786;38224.662136825216;42009.789951050276;42518.787406063006;42556;42626;42641.14717705644;7457.142428620697;7625.733099341524;8636.26591739703;8797;8823.60293786778;10283.691489255298;10552;10557.155427565815;10564.154867610572;10565.15478761701;10187.235957303195;10317.690469285933;10333.741656458573;10341.638042668508;10344.120749736281;7799.649015794303;7978.880316795253;10201.081902628763;10295.3822770634;10601.098906592872;10088.293819432643;10220.948895255477;10227.386356818615;10230.744231394201;10233.846492302622;39812;40216.79891600552;40225.59774402277;40227.7988610058;40241.59758402437;3262.2007608135923;3409.6760807723226;3428.8971330860113;3439.8108104054268;3872.9419058714143;29739.256518586993;30286.091417257518;30328.393432131455;30555.847220763975;31664.525032124537;3567.9643203567894;3574.4459608760685;3604.1530240393486;3732.234891847192;3752.986693592742;271636;272038;273295;274417;362765;45394.77302613466;55262.72368638131;56204.437955620735;56212.71893640506;56255.718721406134;50511.49488505068;50596.74701626542;50743.492565074615;50939.49060509347;50956.49043509592;13247.20516768997;13446.193228406328;13455.32723363828;13512.729745405037;13524.391402386917;10410.427426491615;10653.360798351969;10679.679609611723;10680.51937662807;11010.834837477445;18116.637667246843;18119.184636691116;18124.45626631177;18205.36281230177;18229.54426139357;7667.8849817252785;7692.076980754811;7876.684932602631;7904.446688731734;7946.523208607387;953.93322467428;987.6888780034266;1027.4349107990724;1027.5838285494387;1045.7490202351532;27272.45455090887;27697.307567310978;27826.443471130868;27935;27943.58084628732;985.4481490365418;1022.156720705421;1084.615998085961;1090.7327704712395;1120.9215354925077;13991.930040349733;14009;14019.929900350433;14056.578302650936;14277.64305892361;316200;321363;321518;321980;322381;48404.757976210596;48690;48742.26886596704;48751.756241218565;48869.755651221516;1361.7276544691101;1364.955808806264;1381.785823197406;1387.2716823667656;1389.805427240187;26413.735862641897;27169.04908328278;27253.86373068122;27582.44835103327;27604.44791104207;44039.119217614825;44289.77855110704;44328.556714432445;44389.11221775611;44398.778006109766;285603;288975;289834;290120;290659;26203.213903582924;26526.86736566305;30205;30723.078307650805;31309.8434507826;35018.824905876325;35677.1080722984;35783;36039.459408109426;41656.95857603584;31323;32165.979252593424;32184.19539511531;32606.34787304193;32795.67204328022;29582.260443489085;33229.66770332363;33257.66742332643;34479.13802154966;35183.29633407369;30856;31634.209144771565;31671.366572668878;31728.682713172573;31941.68058319387;28884;30556.541651875683;31189.220269493446;31615.525767113973;31721.682783171873;23824.664546963784;23918;23987.246249338048;24094.277171684877;24253.757462425856 04:59:57 INFO - PROCESS | 25874 | |2;jquery.html;354.1270767557969;360.2650592790707;366.36984386854607;368.6608320345282;370.66640023978425;14104;14368.784468232985;16692.081935493545;17225.48323550294;17950.10249487527;11764.823527647091;13632;13980.860191398084;13984.510542131002;14041.438342466288;5381.0852155133725;5537.280153580049;5540.085885828834;5541.972290138544;5544.63959842611;3629.94555081674;3738.8130593470355;5328.413874473805;5556.6943818089985;5636;5454.781808727646;5456.8090116845915;5474.042042642542;5482.342118945732;5486;5352.785888564453;5457.754401051962;5458.754356053987;5460.918086228709;5469.425710300401;5214.06146893559;5319.2287118368;5319.521243088102;5324.813631522917;5327.946720532784;13167.670808229776;20214.39356819283;20597;20668.79331206684;20701.68947465774;2047.488127968008;2067.2557879163487;2094.549671820566;2105.463106907744;2154.702700560722;9633.710988670351;9652;9695.272854535939;9806.509674516246;9916.405015699082;1840.2179073893676;1852.9166187521594;1870.560418301698;1879.5489082620072;1944.1348599873063;62433;64857;66743.66628166876;67094.32905670929;67234.32765672379;10067.345622534513;10270.691879243635;10412.271141020055;10426.635067772591;10469.999999999847;13909.860901390857;13919.582412527641;13946.721065578631;13954.720905581831;13955.441782328797;6883.793486195422;6911.827204319932;6966.477514186457;6978.476614253951;7188.712451501986;6333.145025421509;6542.705578248991;6746.561473504206;6796.35434633709;6798.082258895085;4094;4371.125774845043;4398.262686238918;4430.446194225722;4551.431071116111;1743.119724539125;1807.53907753522;1809.2582041363241;1824.3341180469033;1863.9534011649816;884.5223579267252;912.5482885971487;913.7350168451208;944.2776276148614;1019.0879163149089;15815.762763558556;15844.52466426009;16542.338306467846;16651.583710407096;16739.16304184786;792.298815548244;857.2242120880613;912.370464379576;988.826955282837;992.2805965674972;8953.507557084293;9270.768230794149;9365.859512107323;9573.138417542315;9767.853482197772;537471;537715;538426;548393;551439;78950.60524697455;83226;83708.16291837125;84556;85223;1130.9717257068476;1150.5915400033034;1159.6231224851956;1160.8490896183612;1162.221311721132;15539.844601554292;15870.444534441702;16092.436764713178;16134.435294764628;16275.674486509966;35029;35428;35438.46842297419;36085.45871811977;36441.63558364382;46582.76708616571;48381;49247.75376123097;50383.74808125936;50393.244101337776;9022.969831787796;9525.428474291288;9546.665866694633;9712.417254964725;9718.562664680248;15151.43963596648;15579.922100389425;15587.92206039008;15714.842851571339;15747.842521575096;12610.747785044432;12675.80986285188;12788.872111278768;12985.220886746825;13287.06990510655;8850.070742571937;9034.503102329434;13140.671483212996;13326.533571324957;13381.19712817234;8728.345374096842;9022.052684468299;9484.52577371115;9617.422954622745;9690.95154524223;13190.736185276433;13576.321183940567;13944.233067181402;14076.648083797987;14135.64660883486;14277.28613569338;14282.857171428153;14747.631309217355;14841;14845.183514906352 04:59:57 INFO - PROCESS | 25874 | |3;mootools.html;1299.8700129986996;1700.2603867317719;1739.7564340992255;1766.9734953975692;1774.6983012887804;6607.174103237096;7444.9949256850305;7586.848263034743;7627.161012288658;7634.809129771745;7502;7547.396208303337;7561.2060733623;7614.314711675948;7666;2235.2400183937457;2274.0789980058103;2274.1699279762934;2274.658801179828;2278.40761402035;2248.4828489447436;2289.839711220207;2295.6097463431256;2299.218265789631;2301.6777651128855;2262.7737226277404;2266.320103968811;2302.1366987379733;2303.7696230376996;2320.8027317677934;2256.4922892349255;2274.5678321119017;2302.3668491165063;2309.93070207894;2310.5263420998654;2308.8730119843403;2338.660894170353;2341.519988402373;2343.61330380487;2344.308429013445;7624;7691.461597688164;7698.1916898725385;7699.807504812368;7704.576248306341;4383.802728877176;4440.755758433317;4447.043885564587;4452.465704115527;4473.105378924228;3004.5042567976257;3040.361524079946;3091.9536206956914;3098.8295643739584;3122.3443076953868;1026.7997740440617;1030.1707125763758;1042.0673497219946;1074.6238816414193;1940.2530025939973;10457.529411176516;10652.307600005975;10704.1436685065;10809.297395669335;10816.945915270451;4242.851500197478;4315.7194782339675;4421.889452763707;4492.685512014127;4504.729716217037;8433.28317093054;8579.142085791496;8614.698485552975;8620.913790862136;8625.223729864343;4606.262997920384;4612.238980568236;4643.4660014098135;4646.140464014168;4646.442426908725;3659.1949771050326;3762.360398732222;4105.624615753696;4218.135282267128;4226.746395216235;3558.1638314995957;3562.625924277965;3577.284543091392;3594.370985077601;3601.7658852174527;1086.435053772034;1099.9175061870392;1101.9724506887233;1102.4653043274006;1110.8222684370462;1011.5751384418414;1030.7526193713454;1031.1493018259966;1141.8801025892162;1289.4906511927736;7273.199948005715;7291.270872912666;7322.3775979042375;7355.5586664800285;7358.926410735931;480.0926249388658;487.8536439068265;488.1384356610585;491.5551425959512;511.9820806271763;5784.59507834456;5790.855228619318;5848.3274423441;5857.853553661193;5858.882822343529;8899.421537600165;9112.316576256808;9125.315601329927;9177.265818734486;9260;9098.772530686785;9165.58754856033;9170.86243706345;9171.862422063674;9187.494687792236;7174.426045916314;7286.089238845145;7315.012473316141;7345.338919497164;7389.630518474055;7022.262662420372;7050.048243487268;7051.189113251837;7055.894161587477;7059.752908648173;8011.359091272568;8139.104698483044;8198.26517967782;8275.710350137717;8322.042965059096;8592.570371481275;8667;8678.175573320525;8683.478991260545;8688.652453901774;6040.969795150996;6273.62358258506;6281.466075383643;6371.936280637135;6497.610143391223;6792.388685018372;6980.511364204457;7019.2629773873;7021.719131234693;7024.613646249505;6632.801015969529;6784.864302714017;6802.455803535607;6811.659417029228;6918.584884906922;6686.987807315571;6741.426978706669;6759;6764.154480689914;6823;6595.406413422815;6666.400023997863;6668.799936001928;6678.131842860397;6679.131712877295;6005.609635373861;6021.698915054142;6042.697865106639;6059.212302400836;6059.969700151471;6152.261728592597;6178.752849885954;6180.042093475518;6190.845228869314;6207 04:59:57 INFO - PROCESS | 25874 | |4;prototype.html;333.68300114890843;340.72741806554757;341.3650609865651;347.85216283079683;350.45679197244266;5848.356680765112;5967.791127310545;5978.521718262539;5991.700414979245;5995.790147344833;5756.338021127572;5879;5888.470037696607;5897.174395584621;5906.350301466835;4602.2406302960135;4602.65480088993;4604.263317869141;4610.9308360374625;4614.561616646413;4404.69167158299;4487.39420178275;4502.2571275739465;4604.171249175147;4610.377599024122;4474.82100715971;4518.870282429392;4552.408186935694;4554.772261386934;4560.315952607102;4527.886802829939;4533.523979982104;4538.591526762607;4569.29175977724;4577.450705915278;4038.353863381845;4039.899002524931;4040.2929487339893;4047.1096358801015;4060.2082593893906;5549.472800083986;5684.289463817023;5715.114157305624;5735.483806457439;5750.913736293959;5252.1596544552685;5256.448072952323;5261.342332208474;5266.973665131688;5276.709780962045;6035.245594300713;6331.715072821734;6331.778387756406;6334.588251763621;6334.746610135635;4271.359296105578;4300.376445415397;4382.671299652538;4416.53626369233;4423.557644235583;6478.514111441614;6568.981807819796;6574.539782215247;6576.901346479806;6577.736890524421;4515.029268707178;4517.435320584927;4518.983228773565;4523.321501774694;4528.049109686936;4503.662225333113;4582.495925448198;4582.931256031162;4585.243434833282;4587.655925805578;5275.657082289639;5277.313949186658;5280.445553216857;5280.709560974184;5286.365636123613;6304.8423789404715;6339.746410143543;6343.175387199634;6346.873062538816;6347.68261586928;1585.4450942170379;1607.4695350534296;1608.4772448954136;1610.090298981072;1613.4111049467094;1067.770429357692;1072.2815713471994;1074.978500429987;1078.3314345106085;1112.0325316974283;6082.817515474543;6084.969575152096;6089.725962331706;6090.116933044772;6096.268447786294;6457.096006559085;6462.903056454157;6482.384173503509;6552.9344706553275;6556.213254409501;5945.286565612154;6078.54410919174;6081.878362432815;6085.2393450818645;6089.5737298388685;3522.7534072615185;3551.076720052805;3554.644535546425;3561.4301711726;3562.1450851795385;6809.931900681029;6811.046453496514;6811.727530898807;6812.420944219797;6820.863582728417;6557.180352455943;6685.732570697215;6686.832829179212;6691.76578819739;6693.196816382066;6762.69567869447;6777.152855893013;6787.966060169668;6809;6812.897806532906;6308.432241098323;6419.646919419477;6474.870502590016;6486.124373209556;6513.413792758674;6419.069234960811;6439.323870993666;6532.118164047793;6535.3464653534265;6535.607863528204;6837.179538455417;6850.897236541556;6857.759978400732;6862.622555759481;6867.759628412981;4389.056352884145;4479.0593975264255;4484.39460672818;4486.618637415856;4486.75322857246;6586.1438013058;6587.769428069994;6587.80236592903;6600.174978127734;6601.867962640624;6408.198975128109;6417.518686098468;6422.26143993428;6423.293437721753;6426.550141490238;6235.96882015587;6396.808095756948;6408.775692850728;6416.743330266924;6417.97312430009;6223;6225.439710426083;6262.561620686508;6278.309385967448;6279.874402512016;6395.456386207038;6418.839529011812;6421.8073457796345;6430.421262086435;6437.839054023687;6192.907106393318;6275.623462592259;6287.46556542699;6288.27684816252;6294.087357333069 04:59:57 INFO - PROCESS | 25874 | |5;yui.html;840.4411066640686;856.9742907712767;859.742077376787;867.4838471109688;871.7689812199773;12508.874911250885;12728.809067863978;12730.554430594942;12755.681107972305;12790.616281511546;12484.875151248485;12559;12559.37203139844;12562.560310389139;12579.685507862308;670.4669787518934;682.1439093937101;820.429801288105;825.7481468152196;835.031363618203;823.8928939237891;830.2237408023487;830.5265998380926;830.9073568257721;831.1273163178669;818.6152508321079;871.5859966515886;876.4259410086404;883.5449743382163;886.3219636977717;867.5705525764755;873.6636394987912;874.108409422392;876.0888675777184;877.385829919056;517.4980269138929;526.2185654303356;527.9841604751864;528.8254875890947;528.8836455979716;11665.533378664928;11834.289942603471;11901.285922844658;11910.583129590423;11917.702057448632;11367.886321136766;12384.442700078518;12564.74870502594;12570.182938108994;12587.685307867285;10151.137153341975;10191.694249172537;10328.948355258175;10402.47987600617;10737.83893241602;3588.8385022674042;3612.187257866959;3618.6603681446404;3652.3608368535665;3686.502322186497;46466.535334646556;46517;46569.767151164364;46624;46662.06675866498;9349.485778282124;9866.901330986599;9899;9980.900190998142;10426.478676066166;17103.74344384835;17171.914140429468;17247.310107595556;17249.56876078083;17273.39543115985;7435.1449583297535;7741.225877412214;7852.725154619561;7902.446828722049;8031.919680803234;4395.5280538698225;4416.712913660666;4450.710703804242;4451.087527056946;4465.866024019285;2998.2654249708526;3020.652624948159;3036.635603727567;3039.0578920534704;3041.315703966634;557.4731878374978;565.4809063539881;568.6105018062558;576.8183022347947;577.7977707802236;663.8605892762478;670.6311528659315;672.3108813466237;724.0876495615562;724.6123324021623;8092.190780921861;8226.465279756796;8278.627461764236;8300.626471808782;8421.452605580618;529.407064088216;543.8613153645795;545.364650182533;659.6899457255082;684.1379861374604;3815.9091136179227;3933.783641899666;3996.660283875845;4018.9799051004557;4069.084455997377;49607.25589116166;49840;50587;50642.74678626657;50775;46677.533224668;48180;48340.758296208995;48584.757076214395;48666;43039.56960430356;43407.13185736331;43715.12569748587;44104.558954410684;44148.89627759268;7809.492382995087;7861.2531809478005;7922.445428819928;7966.3626909848235;8132.878006829784;32998.17504562405;34333;35365.646343537264;35473.64526354807;35590.64409355977;41389;41402;42063.15873682448;42443.3633495504;42487.787561061996;10263.435511046666;10477.266591338534;10496.527656255334;10793.946030269799;10820.134389248684;11236.269642473213;11313.71715707114;11315.547378104784;11327.603533876274;11369.772604548029;10525.89474105249;10608.151347891995;10610.363378197333;10645.680629581126;10658.73353166177;10707.5181616829;11199.60801371948;11215.49530271156;11238.381888996184;11265.436728163722;9192.264618830344;9571.712848614552;9835.114839664464;10666.73333166646;10997.780044398907;8504.957475212832;8590.78523036929;8627.654893804178;8800.823983520422;8840.911590884009;8609.009963854236;8696.347773916856;8853.07042760501;8953.686620968236;9057.456552606865 04:59:57 INFO - PROCESS | 25874 | __end_tp_report 04:59:57 INFO - PROCESS | 25874 | __start_cc_report 04:59:57 INFO - PROCESS | 25874 | _x_x_mozilla_cycle_collect,942 04:59:57 INFO - PROCESS | 25874 | __end_cc_report 04:59:57 INFO - PROCESS | 25874 | __startTimestamp1451048397419__endTimestamp 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | ------- Summary: start ------- 04:59:57 INFO - PROCESS | 25874 | Number of tests: 6 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#0] dojo.html Cycles:165 Average:5313.28 Median:5508.53 stddev:592.79 (10.8%) stddev-sans-first:568.70 04:59:57 INFO - PROCESS | 25874 | Values: 3103.8 3155.7 3201.0 3204.3 3227.9 5182.2 5249.9 5279.3 5289.8 5352.4 5309.9 5310.1 5354.0 5378.9 5421.7 4789.5 4812.4 4826.9 4877.0 4909.8 4801.9 4890.5 4898.8 4921.8 4985.3 4813.6 4848.3 4861.1 4872.1 4917.0 4857.2 4858.9 4861.2 4881.6 4907.5 4839.1 4839.4 4840.9 4867.5 4882.0 5005.7 5048.3 5134.2 5151.3 5174.5 5758.3 5758.3 5760.9 5765.4 5767.4 5573.7 5787.0 5788.8 5800.5 5801.0 5243.8 5281.5 5329.8 5365.5 5371.8 5859.5 5874.2 5883.0 5889.9 5923.8 5444.1 5626.1 5647.4 5647.6 5673.7 5634.5 5692.5 5725.1 5853.0 5894.0 5703.0 5744.0 5749.8 5754.3 5754.5 5580.7 5756.7 5757.6 5759.3 5760.3 4314.6 4366.0 4382.9 4409.6 4420.6 3984.6 3994.4 4000.9 4020.5 4036.0 5423.2 5445.5 5452.9 5459.0 5491.5 5610.6 5676.6 5705.7 5747.0 5751.1 5303.8 5314.6 5327.6 5362.1 5409.9 4889.0 4891.4 4893.7 4905.5 4933.0 5770.1 5911.1 5914.6 5959.5 5963.0 5634.5 5670.8 5685.6 5698.4 5748.0 5945.2 5952.6 5957.2 5959.0 5970.4 5535.1 5632.1 5646.7 5650.0 5685.7 5664.3 5714.0 5737.9 5742.9 5801.2 5669.0 5690.5 5698.1 5699.1 5702.4 5338.4 5427.2 5433.8 5677.3 5679.0 5446.8 5508.5 5515.6 5526.2 5567.3 5631.2 5659.2 5663.3 5673.5 5694.9 5321.5 5497.9 5512.7 5519.1 5527.3 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#1] ext.html Cycles:180 Average:45668.70 Median:173907.76 stddev:78829.24 (45.3%) stddev-sans-first:78977.67 04:59:57 INFO - PROCESS | 25874 | Values: 576.8 587.5 597.7 606.2 610.3 29477.7 37616.6 37951.0 38177.6 38224.7 42009.8 42518.8 42556.0 42626.0 42641.1 7457.1 7625.7 8636.3 8797.0 8823.6 10283.7 10552.0 10557.2 10564.2 10565.2 10187.2 10317.7 10333.7 10341.6 10344.1 7799.6 7978.9 10201.1 10295.4 10601.1 10088.3 10220.9 10227.4 10230.7 10233.8 39812.0 40216.8 40225.6 40227.8 40241.6 3262.2 3409.7 3428.9 3439.8 3872.9 29739.3 30286.1 30328.4 30555.8 31664.5 3568.0 3574.4 3604.2 3732.2 3753.0 271636.0 272038.0 273295.0 274417.0 362765.0 45394.8 55262.7 56204.4 56212.7 56255.7 50511.5 50596.7 50743.5 50939.5 50956.5 13247.2 13446.2 13455.3 13512.7 13524.4 10410.4 10653.4 10679.7 10680.5 11010.8 18116.6 18119.2 18124.5 18205.4 18229.5 7667.9 7692.1 7876.7 7904.4 7946.5 953.9 987.7 1027.4 1027.6 1045.7 27272.5 27697.3 27826.4 27935.0 27943.6 985.4 1022.2 1084.6 1090.7 1120.9 13991.9 14009.0 14019.9 14056.6 14277.6 316200.0 321363.0 321518.0 321980.0 322381.0 48404.8 48690.0 48742.3 48751.8 48869.8 1361.7 1365.0 1381.8 1387.3 1389.8 26413.7 27169.0 27253.9 27582.4 27604.4 44039.1 44289.8 44328.6 44389.1 44398.8 285603.0 288975.0 289834.0 290120.0 290659.0 26203.2 26526.9 30205.0 30723.1 31309.8 35018.8 35677.1 35783.0 36039.5 41657.0 31323.0 32166.0 32184.2 32606.3 32795.7 29582.3 33229.7 33257.7 34479.1 35183.3 30856.0 31634.2 31671.4 31728.7 31941.7 28884.0 30556.5 31189.2 31615.5 31721.7 23824.7 23918.0 23987.2 24094.3 24253.8 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#2] jquery.html Cycles:180 Average:28924.95 Median:3916.41 stddev:88839.78 (2268.4%) stddev-sans-first:89063.10 04:59:57 INFO - PROCESS | 25874 | Values: 354.1 360.3 366.4 368.7 370.7 14104.0 14368.8 16692.1 17225.5 17950.1 11764.8 13632.0 13980.9 13984.5 14041.4 5381.1 5537.3 5540.1 5542.0 5544.6 3629.9 3738.8 5328.4 5556.7 5636.0 5454.8 5456.8 5474.0 5482.3 5486.0 5352.8 5457.8 5458.8 5460.9 5469.4 5214.1 5319.2 5319.5 5324.8 5327.9 13167.7 20214.4 20597.0 20668.8 20701.7 2047.5 2067.3 2094.5 2105.5 2154.7 9633.7 9652.0 9695.3 9806.5 9916.4 1840.2 1852.9 1870.6 1879.5 1944.1 62433.0 64857.0 66743.7 67094.3 67234.3 10067.3 10270.7 10412.3 10426.6 10470.0 13909.9 13919.6 13946.7 13954.7 13955.4 6883.8 6911.8 6966.5 6978.5 7188.7 6333.1 6542.7 6746.6 6796.4 6798.1 4094.0 4371.1 4398.3 4430.4 4551.4 1743.1 1807.5 1809.3 1824.3 1864.0 884.5 912.5 913.7 944.3 1019.1 15815.8 15844.5 16542.3 16651.6 16739.2 792.3 857.2 912.4 988.8 992.3 8953.5 9270.8 9365.9 9573.1 9767.9 537471.0 537715.0 538426.0 548393.0 551439.0 78950.6 83226.0 83708.2 84556.0 85223.0 1131.0 1150.6 1159.6 1160.8 1162.2 15539.8 15870.4 16092.4 16134.4 16275.7 35029.0 35428.0 35438.5 36085.5 36441.6 46582.8 48381.0 49247.8 50383.7 50393.2 9023.0 9525.4 9546.7 9712.4 9718.6 15151.4 15579.9 15587.9 15714.8 15747.8 12610.7 12675.8 12788.9 12985.2 13287.1 8850.1 9034.5 13140.7 13326.5 13381.2 8728.3 9022.1 9484.5 9617.4 9691.0 13190.7 13576.3 13944.2 14076.6 14135.6 14277.3 14282.9 14747.6 14841.0 14845.2 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#3] mootools.html Cycles:180 Average:5315.71 Median:6013.65 stddev:2758.10 (45.9%) stddev-sans-first:2749.32 04:59:57 INFO - PROCESS | 25874 | Values: 1299.9 1700.3 1739.8 1767.0 1774.7 6607.2 7445.0 7586.8 7627.2 7634.8 7502.0 7547.4 7561.2 7614.3 7666.0 2235.2 2274.1 2274.2 2274.7 2278.4 2248.5 2289.8 2295.6 2299.2 2301.7 2262.8 2266.3 2302.1 2303.8 2320.8 2256.5 2274.6 2302.4 2309.9 2310.5 2308.9 2338.7 2341.5 2343.6 2344.3 7624.0 7691.5 7698.2 7699.8 7704.6 4383.8 4440.8 4447.0 4452.5 4473.1 3004.5 3040.4 3092.0 3098.8 3122.3 1026.8 1030.2 1042.1 1074.6 1940.3 10457.5 10652.3 10704.1 10809.3 10816.9 4242.9 4315.7 4421.9 4492.7 4504.7 8433.3 8579.1 8614.7 8620.9 8625.2 4606.3 4612.2 4643.5 4646.1 4646.4 3659.2 3762.4 4105.6 4218.1 4226.7 3558.2 3562.6 3577.3 3594.4 3601.8 1086.4 1099.9 1102.0 1102.5 1110.8 1011.6 1030.8 1031.1 1141.9 1289.5 7273.2 7291.3 7322.4 7355.6 7358.9 480.1 487.9 488.1 491.6 512.0 5784.6 5790.9 5848.3 5857.9 5858.9 8899.4 9112.3 9125.3 9177.3 9260.0 9098.8 9165.6 9170.9 9171.9 9187.5 7174.4 7286.1 7315.0 7345.3 7389.6 7022.3 7050.0 7051.2 7055.9 7059.8 8011.4 8139.1 8198.3 8275.7 8322.0 8592.6 8667.0 8678.2 8683.5 8688.7 6041.0 6273.6 6281.5 6371.9 6497.6 6792.4 6980.5 7019.3 7021.7 7024.6 6632.8 6784.9 6802.5 6811.7 6918.6 6687.0 6741.4 6759.0 6764.2 6823.0 6595.4 6666.4 6668.8 6678.1 6679.1 6005.6 6021.7 6042.7 6059.2 6060.0 6152.3 6178.8 6180.0 6190.8 6207.0 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#4] prototype.html Cycles:180 Average:5305.45 Median:6015.52 stddev:1598.90 (26.6%) stddev-sans-first:1559.23 04:59:57 INFO - PROCESS | 25874 | Values: 333.7 340.7 341.4 347.9 350.5 5848.4 5967.8 5978.5 5991.7 5995.8 5756.3 5879.0 5888.5 5897.2 5906.4 4602.2 4602.7 4604.3 4610.9 4614.6 4404.7 4487.4 4502.3 4604.2 4610.4 4474.8 4518.9 4552.4 4554.8 4560.3 4527.9 4533.5 4538.6 4569.3 4577.5 4038.4 4039.9 4040.3 4047.1 4060.2 5549.5 5684.3 5715.1 5735.5 5750.9 5252.2 5256.4 5261.3 5267.0 5276.7 6035.2 6331.7 6331.8 6334.6 6334.7 4271.4 4300.4 4382.7 4416.5 4423.6 6478.5 6569.0 6574.5 6576.9 6577.7 4515.0 4517.4 4519.0 4523.3 4528.0 4503.7 4582.5 4582.9 4585.2 4587.7 5275.7 5277.3 5280.4 5280.7 5286.4 6304.8 6339.7 6343.2 6346.9 6347.7 1585.4 1607.5 1608.5 1610.1 1613.4 1067.8 1072.3 1075.0 1078.3 1112.0 6082.8 6085.0 6089.7 6090.1 6096.3 6457.1 6462.9 6482.4 6552.9 6556.2 5945.3 6078.5 6081.9 6085.2 6089.6 3522.8 3551.1 3554.6 3561.4 3562.1 6809.9 6811.0 6811.7 6812.4 6820.9 6557.2 6685.7 6686.8 6691.8 6693.2 6762.7 6777.2 6788.0 6809.0 6812.9 6308.4 6419.6 6474.9 6486.1 6513.4 6419.1 6439.3 6532.1 6535.3 6535.6 6837.2 6850.9 6857.8 6862.6 6867.8 4389.1 4479.1 4484.4 4486.6 4486.8 6586.1 6587.8 6587.8 6600.2 6601.9 6408.2 6417.5 6422.3 6423.3 6426.6 6236.0 6396.8 6408.8 6416.7 6418.0 6223.0 6225.4 6262.6 6278.3 6279.9 6395.5 6418.8 6421.8 6430.4 6437.8 6192.9 6275.6 6287.5 6288.3 6294.1 04:59:57 INFO - PROCESS | 25874 | 04:59:57 INFO - PROCESS | 25874 | [#5] yui.html Cycles:180 Average:13028.31 Median:46596.88 stddev:14832.81 (31.8%) stddev-sans-first:14846.18 04:59:57 INFO - PROCESS | 25874 | Values: 840.4 857.0 859.7 867.5 871.8 12508.9 12728.8 12730.6 12755.7 12790.6 12484.9 12559.0 12559.4 12562.6 12579.7 670.5 682.1 820.4 825.7 835.0 823.9 830.2 830.5 830.9 831.1 818.6 871.6 876.4 883.5 886.3 867.6 873.7 874.1 876.1 877.4 517.5 526.2 528.0 528.8 528.9 11665.5 11834.3 11901.3 11910.6 11917.7 11367.9 12384.4 12564.7 12570.2 12587.7 10151.1 10191.7 10328.9 10402.5 10737.8 3588.8 3612.2 3618.7 3652.4 3686.5 46466.5 46517.0 46569.8 46624.0 46662.1 9349.5 9866.9 9899.0 9980.9 10426.5 17103.7 17171.9 17247.3 17249.6 17273.4 7435.1 7741.2 7852.7 7902.4 8031.9 4395.5 4416.7 4450.7 4451.1 4465.9 2998.3 3020.7 3036.6 3039.1 3041.3 557.5 565.5 568.6 576.8 577.8 663.9 670.6 672.3 724.1 724.6 8092.2 8226.5 8278.6 8300.6 8421.5 529.4 543.9 545.4 659.7 684.1 3815.9 3933.8 3996.7 4019.0 4069.1 49607.3 49840.0 50587.0 50642.7 50775.0 46677.5 48180.0 48340.8 48584.8 48666.0 43039.6 43407.1 43715.1 44104.6 44148.9 7809.5 7861.3 7922.4 7966.4 8132.9 32998.2 34333.0 35365.6 35473.6 35590.6 41389.0 41402.0 42063.2 42443.4 42487.8 10263.4 10477.3 10496.5 10793.9 10820.1 11236.3 11313.7 11315.5 11327.6 11369.8 10525.9 10608.2 10610.4 10645.7 10658.7 10707.5 11199.6 11215.5 11238.4 11265.4 9192.3 9571.7 9835.1 10666.7 10997.8 8505.0 8590.8 8627.7 8800.8 8840.9 8609.0 8696.3 8853.1 8953.7 9057.5 04:59:57 INFO - PROCESS | 25874 | -------- Summary: end -------- 04:59:57 INFO - PROCESS | 25874 | 04:59:58 INFO - TEST-INFO | 25874: exit 0 04:59:58 INFO - TEST-OK | dromaeo_css | took 1114115ms 04:59:58 INFO - TEST-START | kraken 04:59:58 INFO - operating with platform_type : linux_ 04:59:58 INFO - Initialising browser for kraken test... 04:59:58 INFO - TEST-INFO | started process 26063 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9NDj_2/profile http://localhost:41878/getInfo.html) 05:00:03 INFO - PROCESS | 26063 | __metrics Screen width/height:1600/1200 05:00:03 INFO - PROCESS | 26063 | colorDepth:24 05:00:03 INFO - PROCESS | 26063 | Browser inner width/height: 1024/697 05:00:03 INFO - PROCESS | 26063 | __metrics 05:00:03 INFO - PROCESS | 26063 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:00:03 INFO - PROCESS | 26063 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:00:04 INFO - TEST-INFO | 26063: exit 0 05:00:04 INFO - Browser initialized. 05:00:04 INFO - Running cycle 1/1 for kraken test... 05:00:04 INFO - TEST-INFO | started process 26149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9NDj_2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:00:16 INFO - PROCESS | 26149 | RSS: Main: 149909504 05:00:16 INFO - PROCESS | 26149 | 05:00:18 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41878/tests/kraken/driver.html?testName=audio-beat-detection) 05:00:19 INFO - PROCESS | 26149 | RSS: Main: 186290176 05:00:19 INFO - PROCESS | 26149 | 05:00:21 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41878/tests/kraken/driver.html?testName=audio-dft) 05:00:22 INFO - PROCESS | 26149 | RSS: Main: 176812032 05:00:22 INFO - PROCESS | 26149 | 05:00:25 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41878/tests/kraken/driver.html?testName=audio-fft) 05:00:25 INFO - PROCESS | 26149 | RSS: Main: 160395264 05:00:25 INFO - PROCESS | 26149 | 05:00:27 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41878/tests/kraken/driver.html?testName=audio-oscillator) 05:00:28 INFO - PROCESS | 26149 | RSS: Main: 163876864 05:00:28 INFO - PROCESS | 26149 | 05:00:30 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:00:31 INFO - PROCESS | 26149 | RSS: Main: 165384192 05:00:31 INFO - PROCESS | 26149 | 05:00:33 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41878/tests/kraken/driver.html?testName=imaging-darkroom) 05:00:34 INFO - PROCESS | 26149 | RSS: Main: 164990976 05:00:34 INFO - PROCESS | 26149 | 05:00:37 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41878/tests/kraken/driver.html?testName=imaging-desaturate) 05:00:38 INFO - PROCESS | 26149 | RSS: Main: 166629376 05:00:38 INFO - PROCESS | 26149 | 05:00:41 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41878/tests/kraken/driver.html?testName=json-parse-financial) 05:00:41 INFO - PROCESS | 26149 | RSS: Main: 164773888 05:00:41 INFO - PROCESS | 26149 | 05:00:43 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:00:44 INFO - PROCESS | 26149 | RSS: Main: 176611328 05:00:44 INFO - PROCESS | 26149 | 05:00:45 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:00:46 INFO - PROCESS | 26149 | RSS: Main: 175489024 05:00:46 INFO - PROCESS | 26149 | 05:00:48 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:00:49 INFO - PROCESS | 26149 | RSS: Main: 182784000 05:00:49 INFO - PROCESS | 26149 | 05:00:51 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:00:52 INFO - PROCESS | 26149 | RSS: Main: 191188992 05:00:52 INFO - PROCESS | 26149 | 05:00:54 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:00:55 INFO - PROCESS | 26149 | RSS: Main: 186335232 05:00:55 INFO - PROCESS | 26149 | 05:00:56 INFO - PROCESS | 26149 | Cycle 1(1): loaded http://localhost:41878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41878/tests/kraken/driver.html?testName=ai-astar) 05:00:57 INFO - PROCESS | 26149 | RSS: Main: 245329920 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | __start_tp_report 05:00:57 INFO - PROCESS | 26149 | _x_x_mozilla_page_load 05:00:57 INFO - PROCESS | 26149 | _x_x_mozilla_page_load_details 05:00:57 INFO - PROCESS | 26149 | |i|pagename|runs| 05:00:57 INFO - PROCESS | 26149 | |0;ai-astar;110;110;105;110;113;111;100;113;111;118 05:00:57 INFO - PROCESS | 26149 | |1;audio-beat-detection;158;128;155;163;124;155;146;124;161;129 05:00:57 INFO - PROCESS | 26149 | |2;audio-dft;162;162;160;162;160;162;160;164;163;162 05:00:57 INFO - PROCESS | 26149 | |3;audio-fft;72;73;88;95;70;72;72;110;89;71 05:00:57 INFO - PROCESS | 26149 | |4;audio-oscillator;93;95;148;93;95;96;140;92;93;135 05:00:57 INFO - PROCESS | 26149 | |5;imaging-gaussian-blur;110;109;110;109;109;109;109;110;109;109 05:00:57 INFO - PROCESS | 26149 | |6;imaging-darkroom;147;147;146;147;146;147;197;146;147;146 05:00:57 INFO - PROCESS | 26149 | |7;imaging-desaturate;96;95;96;95;97;95;95;96;96;95 05:00:57 INFO - PROCESS | 26149 | |8;json-parse-financial;57;57;61;58;56;57;58;66;55;56 05:00:57 INFO - PROCESS | 26149 | |9;json-stringify-tinderbox;67;67;68;67;67;67;69;68;67;68 05:00:57 INFO - PROCESS | 26149 | |10;stanford-crypto-aes;84;85;83;85;85;83;93;92;86;84 05:00:57 INFO - PROCESS | 26149 | |11;stanford-crypto-ccm;121;123;123;121;128;119;126;120;117;122 05:00:57 INFO - PROCESS | 26149 | |12;stanford-crypto-pbkdf2;146;153;149;152;153;143;155;151;150;140 05:00:57 INFO - PROCESS | 26149 | |13;stanford-crypto-sha256-iterative;67;67;68;68;67;67;69;67;68;69 05:00:57 INFO - PROCESS | 26149 | __end_tp_report 05:00:57 INFO - PROCESS | 26149 | __start_cc_report 05:00:57 INFO - PROCESS | 26149 | _x_x_mozilla_cycle_collect,913 05:00:57 INFO - PROCESS | 26149 | __end_cc_report 05:00:57 INFO - PROCESS | 26149 | __startTimestamp1451048457130__endTimestamp 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | ------- Summary: start ------- 05:00:57 INFO - PROCESS | 26149 | Number of tests: 14 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:4.82 (4.3%) stddev-sans-first:5.11 05:00:57 INFO - PROCESS | 26149 | Values: 110.0 110.0 105.0 110.0 113.0 111.0 100.0 113.0 111.0 118.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:155.00 stddev:16.23 (10.5%) stddev-sans-first:16.45 05:00:57 INFO - PROCESS | 26149 | Values: 158.0 128.0 155.0 163.0 124.0 155.0 146.0 124.0 161.0 129.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 05:00:57 INFO - PROCESS | 26149 | Values: 162.0 162.0 160.0 162.0 160.0 162.0 160.0 164.0 163.0 162.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#3] audio-fft Cycles:10 Average:81.20 Median:72.50 stddev:13.65 (18.8%) stddev-sans-first:14.07 05:00:57 INFO - PROCESS | 26149 | Values: 72.0 73.0 88.0 95.0 70.0 72.0 72.0 110.0 89.0 71.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:93.00 stddev:23.01 (24.7%) stddev-sans-first:23.76 05:00:57 INFO - PROCESS | 26149 | Values: 93.0 95.0 148.0 93.0 95.0 96.0 140.0 92.0 93.0 135.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 05:00:57 INFO - PROCESS | 26149 | Values: 110.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:147.00 stddev:15.96 (10.9%) stddev-sans-first:16.84 05:00:57 INFO - PROCESS | 26149 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 197.0 146.0 147.0 146.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 05:00:57 INFO - PROCESS | 26149 | Values: 96.0 95.0 96.0 95.0 97.0 95.0 95.0 96.0 96.0 95.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.50 stddev:3.21 (5.6%) stddev-sans-first:3.38 05:00:57 INFO - PROCESS | 26149 | Values: 57.0 57.0 61.0 58.0 56.0 57.0 58.0 66.0 55.0 56.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:67.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 05:00:57 INFO - PROCESS | 26149 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 69.0 68.0 67.0 68.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.56 (4.2%) stddev-sans-first:3.70 05:00:57 INFO - PROCESS | 26149 | Values: 84.0 85.0 83.0 85.0 85.0 83.0 93.0 92.0 86.0 84.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:122.50 stddev:3.23 (2.6%) stddev-sans-first:3.41 05:00:57 INFO - PROCESS | 26149 | Values: 121.0 123.0 123.0 121.0 128.0 119.0 126.0 120.0 117.0 122.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.50 stddev:4.80 (3.2%) stddev-sans-first:4.95 05:00:57 INFO - PROCESS | 26149 | Values: 146.0 153.0 149.0 152.0 153.0 143.0 155.0 151.0 150.0 140.0 05:00:57 INFO - PROCESS | 26149 | 05:00:57 INFO - PROCESS | 26149 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 05:00:57 INFO - PROCESS | 26149 | Values: 67.0 67.0 68.0 68.0 67.0 67.0 69.0 67.0 68.0 69.0 05:00:57 INFO - PROCESS | 26149 | -------- Summary: end -------- 05:00:57 INFO - PROCESS | 26149 | 05:00:58 INFO - TEST-INFO | 26149: exit 0 05:00:58 INFO - TEST-OK | kraken | took 59891ms 05:00:58 INFO - TEST-START | v8_7 05:00:58 INFO - operating with platform_type : linux_ 05:00:58 INFO - Initialising browser for v8_7 test... 05:00:58 INFO - TEST-INFO | started process 26399 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5XnCZb/profile http://localhost:41878/getInfo.html) 05:01:02 INFO - PROCESS | 26399 | __metrics Screen width/height:1600/1200 05:01:02 INFO - PROCESS | 26399 | colorDepth:24 05:01:02 INFO - PROCESS | 26399 | Browser inner width/height: 1024/697 05:01:02 INFO - PROCESS | 26399 | __metrics 05:01:02 INFO - PROCESS | 26399 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:01:02 INFO - PROCESS | 26399 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:04 INFO - TEST-INFO | 26399: exit 0 05:01:04 INFO - Browser initialized. 05:01:04 INFO - Running cycle 1/1 for v8_7 test... 05:01:04 INFO - TEST-INFO | started process 26481 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5XnCZb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:15 INFO - PROCESS | 26481 | RSS: Main: 149491712 05:01:15 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | Cycle 1(1): loaded http://localhost:41878/tests/v8_7/run.html (next: http://localhost:41878/tests/v8_7/run.html) 05:01:37 INFO - PROCESS | 26481 | RSS: Main: 567730176 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | __start_tp_report 05:01:37 INFO - PROCESS | 26481 | _x_x_mozilla_page_load 05:01:37 INFO - PROCESS | 26481 | _x_x_mozilla_page_load_details 05:01:37 INFO - PROCESS | 26481 | |i|pagename|runs| 05:01:37 INFO - PROCESS | 26481 | |0;Richards;166.44474034620507 05:01:37 INFO - PROCESS | 26481 | |1;DeltaBlue;190.4036557501904 05:01:37 INFO - PROCESS | 26481 | |2;Encrypt;280.2690582959641 05:01:37 INFO - PROCESS | 26481 | |3;Decrypt;5202.072538860104 05:01:37 INFO - PROCESS | 26481 | |4;RayTrace;1919.3857965451057 05:01:37 INFO - PROCESS | 26481 | |5;Earley;789.8894154818325 05:01:37 INFO - PROCESS | 26481 | |6;Boyer;12204.819277108434 05:01:37 INFO - PROCESS | 26481 | |7;RegExp;26342.105263157893 05:01:37 INFO - PROCESS | 26481 | |8;Splay;592.0663114268798 05:01:37 INFO - PROCESS | 26481 | |9;NavierStokes;4830.917874396136 05:01:37 INFO - PROCESS | 26481 | __end_tp_report 05:01:37 INFO - PROCESS | 26481 | __startTimestamp1451048497623__endTimestamp 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | ------- Summary: start ------- 05:01:37 INFO - PROCESS | 26481 | Number of tests: 10 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 166.4 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#1] DeltaBlue Cycles:1 Average:190.40 Median:190.40 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 190.4 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 280.3 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 5202.1 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#4] RayTrace Cycles:1 Average:1919.39 Median:1919.39 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 1919.4 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 789.9 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 12204.8 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 26342.1 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#8] Splay Cycles:1 Average:592.07 Median:592.07 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 592.1 05:01:37 INFO - PROCESS | 26481 | 05:01:37 INFO - PROCESS | 26481 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 05:01:37 INFO - PROCESS | 26481 | Values: 4830.9 05:01:37 INFO - PROCESS | 26481 | -------- Summary: end -------- 05:01:37 INFO - PROCESS | 26481 | 05:01:38 INFO - TEST-INFO | 26481: exit 0 05:01:38 INFO - TEST-OK | v8_7 | took 40365ms 05:01:38 INFO - SUITE-END | took 1214s 05:01:38 INFO - Completed test suite (00:20:14) 05:01:38 INFO - Working with test: dromaeo_css 05:01:38 INFO - Generating results file: dromaeo_css 05:01:38 INFO - Working with test: kraken 05:01:38 INFO - Generating results file: kraken 05:01:38 INFO - javascript benchmark 05:01:38 INFO - Working with test: v8_7 05:01:38 INFO - Generating results file: v8_7 05:01:38 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 05:01:38 INFO - process_Request line: dromaeo_css 6858.18 graph.html#tests=[[72,201,35]] 05:01:38 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - process_Request line: kraken 1512.30 graph.html#tests=[[232,201,35]] 05:01:38 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:01:38 INFO - process_Request line: v8_7 19884.39 graph.html#tests=[[230,201,35]] 05:01:38 INFO - RETURN: dromaeo_css: 6858.18 05:01:38 INFO - RETURN: kraken: 1512.30 05:01:38 INFO - RETURN: v8_7: 19884.39 05:01:38 INFO - javascript benchmark 05:01:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.8137711737295, 3155.731762800162, 3201.0396880935727, 3204.3110731192787, 3227.8708851645933, 5182.196759502273, 5249.8687532811655, 5279.313689220401, 5289.814856480024, 5352.357717073952, 5309.867253318669, 5310.123829568126, 5354.0, 5378.865528361793, 5421.728913554326, 4789.473157952622, 4812.422509298889, 4826.927596086061, 4877.0, 4909.7545122743895, 4801.90396192076, 4890.535399137077, 4898.804047838083, 4921.753912304388, 4985.302057711923, 4813.6389770767155, 4848.296996935443, 4861.052094841507, 4872.1473742094995, 4917.041176970492, 4857.247126695368, 4858.902821943541, 4861.246506791453, 4881.6338774591695, 4907.460179380265, 4839.080574690797, 4839.395075615548, 4840.927386089212, 4867.537583929557, 4881.974785295092, 5005.6996580205305, 5048.268001139814, 5134.229865520165, 5151.304573882516, 5174.482551744795, 5758.2514273144225, 5758.309002919635, 5760.855978600526, 5765.423457654243, 5767.36558978512, 5573.665580065209, 5787.0, 5788.768449262025, 5800.506956908668, 5800.9709951450395, 5243.842684719464, 5281.524662780368, 5329.81345652908, 5365.490278423544, 5371.785128594852, 5859.472647461749, 5874.206982057453, 5883.0, 5889.852753681193, 5923.7926672566255, 5444.074507333763, 5626.127950167731, 5647.37878833328, 5647.576431767634, 5673.716314184274, 5634.464725851038, 5692.459216374438, 5725.055365864586, 5853.03424934881, 5894.0, 5703.0, 5744.0, 5749.8275051748515, 5754.251947246915, 5754.4533269339345, 5580.720963951786, 5756.683382414008, 5757.596968212185, 5759.337676167294, 5760.279965004374, 4314.633256173198, 4365.956340436618, 4382.868513944587, 4409.647228221735, 4420.58004489573, 3984.641382275551, 3994.4407782910416, 4000.899977500586, 4020.4773379460485, 4036.0313524753847, 5423.240746295522, 5445.455454454602, 5452.945470545323, 5458.972705136528, 5491.450854914477, 5610.635308704921, 5676.602637815313, 5705.74324155414, 5747.0, 5751.051076572402, 5303.787848486095, 5314.5748340132695, 5327.627066105335, 5362.1420572708175, 5409.891802164014, 4889.046635905964, 4891.388576427947, 4893.657443978887, 4905.509449055137, 4932.950670493321, 5770.105633626795, 5911.083782013795, 5914.645121292736, 5959.493443057302, 5962.97018514922, 5634.464725851038, 5670.829875103754, 5685.573581981285, 5698.430156984268, 5747.97126014384, 5945.197398351167, 5952.613080149777, 5957.225560677258, 5959.046552551571, 5970.402959703995, 5535.114381698909, 5632.098864181711, 5646.71766411686, 5649.971750141387, 5685.658860468385, 5664.291963504562, 5714.0, 5737.9139312911175, 5742.885142297214, 5801.1878337033695, 5669.0, 5690.487856092972, 5698.0598201296325, 5699.145128230799, 5702.37273899879, 5338.3593968724, 5427.185922111715, 5433.8369848904595, 5677.290338707661, 5679.034564124191, 5446.754896029767, 5508.531774799027, 5515.61390702647, 5526.22632831412, 5567.3040869891265, 5631.183478395692, 5659.207710920557, 5663.348714897839, 5673.489385955284, 5694.9179655865255, 5321.467853214647, 5497.862553436036, 5512.724363781875, 5519.089350257163, 5527.2538207341495], "unit": "score", "name": "dojo.html", "value": 5274.760724288134}, {"lowerIsBetter": false, "replicates": [576.7614410341129, 587.5064945445828, 597.7310210405313, 606.2391698418484, 610.3012051201376, 29477.705222947792, 37616.62383376169, 37951.0, 38177.618223817786, 38224.662136825216, 42009.789951050276, 42518.787406063006, 42556.0, 42626.0, 42641.14717705644, 7457.142428620697, 7625.733099341524, 8636.26591739703, 8797.0, 8823.60293786778, 10283.691489255298, 10552.0, 10557.155427565815, 10564.154867610572, 10565.15478761701, 10187.235957303195, 10317.690469285933, 10333.741656458573, 10341.638042668508, 10344.120749736281, 7799.649015794303, 7978.880316795253, 10201.081902628763, 10295.3822770634, 10601.098906592872, 10088.293819432643, 10220.948895255477, 10227.386356818615, 10230.744231394201, 10233.846492302622, 39812.0, 40216.79891600552, 40225.59774402277, 40227.7988610058, 40241.59758402437, 3262.2007608135923, 3409.6760807723226, 3428.8971330860113, 3439.8108104054268, 3872.9419058714143, 29739.256518586993, 30286.091417257518, 30328.393432131455, 30555.847220763975, 31664.525032124537, 3567.9643203567894, 3574.4459608760685, 3604.1530240393486, 3732.234891847192, 3752.986693592742, 271636.0, 272038.0, 273295.0, 274417.0, 362765.0, 45394.77302613466, 55262.72368638131, 56204.437955620735, 56212.71893640506, 56255.718721406134, 50511.49488505068, 50596.74701626542, 50743.492565074615, 50939.49060509347, 50956.49043509592, 13247.20516768997, 13446.193228406328, 13455.32723363828, 13512.729745405037, 13524.391402386917, 10410.427426491615, 10653.360798351969, 10679.679609611723, 10680.51937662807, 11010.834837477445, 18116.637667246843, 18119.184636691116, 18124.45626631177, 18205.36281230177, 18229.54426139357, 7667.8849817252785, 7692.076980754811, 7876.684932602631, 7904.446688731734, 7946.523208607387, 953.93322467428, 987.6888780034266, 1027.4349107990724, 1027.5838285494387, 1045.7490202351532, 27272.45455090887, 27697.307567310978, 27826.443471130868, 27935.0, 27943.58084628732, 985.4481490365418, 1022.156720705421, 1084.615998085961, 1090.7327704712395, 1120.9215354925077, 13991.930040349733, 14009.0, 14019.929900350433, 14056.578302650936, 14277.64305892361, 316200.0, 321363.0, 321518.0, 321980.0, 322381.0, 48404.757976210596, 48690.0, 48742.26886596704, 48751.756241218565, 48869.755651221516, 1361.7276544691101, 1364.955808806264, 1381.785823197406, 1387.2716823667656, 1389.805427240187, 26413.735862641897, 27169.04908328278, 27253.86373068122, 27582.44835103327, 27604.44791104207, 44039.119217614825, 44289.77855110704, 44328.556714432445, 44389.11221775611, 44398.778006109766, 285603.0, 288975.0, 289834.0, 290120.0, 290659.0, 26203.213903582924, 26526.86736566305, 30205.0, 30723.078307650805, 31309.8434507826, 35018.824905876325, 35677.1080722984, 35783.0, 36039.459408109426, 41656.95857603584, 31323.0, 32165.979252593424, 32184.19539511531, 32606.34787304193, 32795.67204328022, 29582.260443489085, 33229.66770332363, 33257.66742332643, 34479.13802154966, 35183.29633407369, 30856.0, 31634.209144771565, 31671.366572668878, 31728.682713172573, 31941.68058319387, 28884.0, 30556.541651875683, 31189.220269493446, 31615.525767113973, 31721.682783171873, 23824.664546963784, 23918.0, 23987.246249338048, 24094.277171684877, 24253.757462425856], "unit": "score", "name": "ext.html", "value": 18033.750945708187}, {"lowerIsBetter": false, "replicates": [354.1270767557969, 360.2650592790707, 366.36984386854607, 368.6608320345282, 370.66640023978425, 14104.0, 14368.784468232985, 16692.081935493545, 17225.48323550294, 17950.10249487527, 11764.823527647091, 13632.0, 13980.860191398084, 13984.510542131002, 14041.438342466288, 5381.0852155133725, 5537.280153580049, 5540.085885828834, 5541.972290138544, 5544.63959842611, 3629.94555081674, 3738.8130593470355, 5328.413874473805, 5556.6943818089985, 5636.0, 5454.781808727646, 5456.8090116845915, 5474.042042642542, 5482.342118945732, 5486.0, 5352.785888564453, 5457.754401051962, 5458.754356053987, 5460.918086228709, 5469.425710300401, 5214.06146893559, 5319.2287118368, 5319.521243088102, 5324.813631522917, 5327.946720532784, 13167.670808229776, 20214.39356819283, 20597.0, 20668.79331206684, 20701.68947465774, 2047.488127968008, 2067.2557879163487, 2094.549671820566, 2105.463106907744, 2154.702700560722, 9633.710988670351, 9652.0, 9695.272854535939, 9806.509674516246, 9916.405015699082, 1840.2179073893676, 1852.9166187521594, 1870.560418301698, 1879.5489082620072, 1944.1348599873063, 62433.0, 64857.0, 66743.66628166876, 67094.32905670929, 67234.32765672379, 10067.345622534513, 10270.691879243635, 10412.271141020055, 10426.635067772591, 10469.999999999847, 13909.860901390857, 13919.582412527641, 13946.721065578631, 13954.720905581831, 13955.441782328797, 6883.793486195422, 6911.827204319932, 6966.477514186457, 6978.476614253951, 7188.712451501986, 6333.145025421509, 6542.705578248991, 6746.561473504206, 6796.35434633709, 6798.082258895085, 4094.0, 4371.125774845043, 4398.262686238918, 4430.446194225722, 4551.431071116111, 1743.119724539125, 1807.53907753522, 1809.2582041363241, 1824.3341180469033, 1863.9534011649816, 884.5223579267252, 912.5482885971487, 913.7350168451208, 944.2776276148614, 1019.0879163149089, 15815.762763558556, 15844.52466426009, 16542.338306467846, 16651.583710407096, 16739.16304184786, 792.298815548244, 857.2242120880613, 912.370464379576, 988.826955282837, 992.2805965674972, 8953.507557084293, 9270.768230794149, 9365.859512107323, 9573.138417542315, 9767.853482197772, 537471.0, 537715.0, 538426.0, 548393.0, 551439.0, 78950.60524697455, 83226.0, 83708.16291837125, 84556.0, 85223.0, 1130.9717257068476, 1150.5915400033034, 1159.6231224851956, 1160.8490896183612, 1162.221311721132, 15539.844601554292, 15870.444534441702, 16092.436764713178, 16134.435294764628, 16275.674486509966, 35029.0, 35428.0, 35438.46842297419, 36085.45871811977, 36441.63558364382, 46582.76708616571, 48381.0, 49247.75376123097, 50383.74808125936, 50393.244101337776, 9022.969831787796, 9525.428474291288, 9546.665866694633, 9712.417254964725, 9718.562664680248, 15151.43963596648, 15579.922100389425, 15587.92206039008, 15714.842851571339, 15747.842521575096, 12610.747785044432, 12675.80986285188, 12788.872111278768, 12985.220886746825, 13287.06990510655, 8850.070742571937, 9034.503102329434, 13140.671483212996, 13326.533571324957, 13381.19712817234, 8728.345374096842, 9022.052684468299, 9484.52577371115, 9617.422954622745, 9690.95154524223, 13190.736185276433, 13576.321183940567, 13944.233067181402, 14076.648083797987, 14135.64660883486, 14277.28613569338, 14282.857171428153, 14747.631309217355, 14841.0, 14845.183514906352], "unit": "score", "name": "jquery.html", "value": 8694.390228935948}, {"lowerIsBetter": false, "replicates": [1299.8700129986996, 1700.2603867317719, 1739.7564340992255, 1766.9734953975692, 1774.6983012887804, 6607.174103237096, 7444.9949256850305, 7586.848263034743, 7627.161012288658, 7634.809129771745, 7502.0, 7547.396208303337, 7561.2060733623, 7614.314711675948, 7666.0, 2235.2400183937457, 2274.0789980058103, 2274.1699279762934, 2274.658801179828, 2278.40761402035, 2248.4828489447436, 2289.839711220207, 2295.6097463431256, 2299.218265789631, 2301.6777651128855, 2262.7737226277404, 2266.320103968811, 2302.1366987379733, 2303.7696230376996, 2320.8027317677934, 2256.4922892349255, 2274.5678321119017, 2302.3668491165063, 2309.93070207894, 2310.5263420998654, 2308.8730119843403, 2338.660894170353, 2341.519988402373, 2343.61330380487, 2344.308429013445, 7624.0, 7691.461597688164, 7698.1916898725385, 7699.807504812368, 7704.576248306341, 4383.802728877176, 4440.755758433317, 4447.043885564587, 4452.465704115527, 4473.105378924228, 3004.5042567976257, 3040.361524079946, 3091.9536206956914, 3098.8295643739584, 3122.3443076953868, 1026.7997740440617, 1030.1707125763758, 1042.0673497219946, 1074.6238816414193, 1940.2530025939973, 10457.529411176516, 10652.307600005975, 10704.1436685065, 10809.297395669335, 10816.945915270451, 4242.851500197478, 4315.7194782339675, 4421.889452763707, 4492.685512014127, 4504.729716217037, 8433.28317093054, 8579.142085791496, 8614.698485552975, 8620.913790862136, 8625.223729864343, 4606.262997920384, 4612.238980568236, 4643.4660014098135, 4646.140464014168, 4646.442426908725, 3659.1949771050326, 3762.360398732222, 4105.624615753696, 4218.135282267128, 4226.746395216235, 3558.1638314995957, 3562.625924277965, 3577.284543091392, 3594.370985077601, 3601.7658852174527, 1086.435053772034, 1099.9175061870392, 1101.9724506887233, 1102.4653043274006, 1110.8222684370462, 1011.5751384418414, 1030.7526193713454, 1031.1493018259966, 1141.8801025892162, 1289.4906511927736, 7273.199948005715, 7291.270872912666, 7322.3775979042375, 7355.5586664800285, 7358.926410735931, 480.0926249388658, 487.8536439068265, 488.1384356610585, 491.5551425959512, 511.9820806271763, 5784.59507834456, 5790.855228619318, 5848.3274423441, 5857.853553661193, 5858.882822343529, 8899.421537600165, 9112.316576256808, 9125.315601329927, 9177.265818734486, 9260.0, 9098.772530686785, 9165.58754856033, 9170.86243706345, 9171.862422063674, 9187.494687792236, 7174.426045916314, 7286.089238845145, 7315.012473316141, 7345.338919497164, 7389.630518474055, 7022.262662420372, 7050.048243487268, 7051.189113251837, 7055.894161587477, 7059.752908648173, 8011.359091272568, 8139.104698483044, 8198.26517967782, 8275.710350137717, 8322.042965059096, 8592.570371481275, 8667.0, 8678.175573320525, 8683.478991260545, 8688.652453901774, 6040.969795150996, 6273.62358258506, 6281.466075383643, 6371.936280637135, 6497.610143391223, 6792.388685018372, 6980.511364204457, 7019.2629773873, 7021.719131234693, 7024.613646249505, 6632.801015969529, 6784.864302714017, 6802.455803535607, 6811.659417029228, 6918.584884906922, 6686.987807315571, 6741.426978706669, 6759.0, 6764.154480689914, 6823.0, 6595.406413422815, 6666.400023997863, 6668.799936001928, 6678.131842860397, 6679.131712877295, 6005.609635373861, 6021.698915054142, 6042.697865106639, 6059.212302400836, 6059.969700151471, 6152.261728592597, 6178.752849885954, 6180.042093475518, 6190.845228869314, 6207.0], "unit": "score", "name": "mootools.html", "value": 4324.302396638973}, {"lowerIsBetter": false, "replicates": [333.68300114890843, 340.72741806554757, 341.3650609865651, 347.85216283079683, 350.45679197244266, 5848.356680765112, 5967.791127310545, 5978.521718262539, 5991.700414979245, 5995.790147344833, 5756.338021127572, 5879.0, 5888.470037696607, 5897.174395584621, 5906.350301466835, 4602.2406302960135, 4602.65480088993, 4604.263317869141, 4610.9308360374625, 4614.561616646413, 4404.69167158299, 4487.39420178275, 4502.2571275739465, 4604.171249175147, 4610.377599024122, 4474.82100715971, 4518.870282429392, 4552.408186935694, 4554.772261386934, 4560.315952607102, 4527.886802829939, 4533.523979982104, 4538.591526762607, 4569.29175977724, 4577.450705915278, 4038.353863381845, 4039.899002524931, 4040.2929487339893, 4047.1096358801015, 4060.2082593893906, 5549.472800083986, 5684.289463817023, 5715.114157305624, 5735.483806457439, 5750.913736293959, 5252.1596544552685, 5256.448072952323, 5261.342332208474, 5266.973665131688, 5276.709780962045, 6035.245594300713, 6331.715072821734, 6331.778387756406, 6334.588251763621, 6334.746610135635, 4271.359296105578, 4300.376445415397, 4382.671299652538, 4416.53626369233, 4423.557644235583, 6478.514111441614, 6568.981807819796, 6574.539782215247, 6576.901346479806, 6577.736890524421, 4515.029268707178, 4517.435320584927, 4518.983228773565, 4523.321501774694, 4528.049109686936, 4503.662225333113, 4582.495925448198, 4582.931256031162, 4585.243434833282, 4587.655925805578, 5275.657082289639, 5277.313949186658, 5280.445553216857, 5280.709560974184, 5286.365636123613, 6304.8423789404715, 6339.746410143543, 6343.175387199634, 6346.873062538816, 6347.68261586928, 1585.4450942170379, 1607.4695350534296, 1608.4772448954136, 1610.090298981072, 1613.4111049467094, 1067.770429357692, 1072.2815713471994, 1074.978500429987, 1078.3314345106085, 1112.0325316974283, 6082.817515474543, 6084.969575152096, 6089.725962331706, 6090.116933044772, 6096.268447786294, 6457.096006559085, 6462.903056454157, 6482.384173503509, 6552.9344706553275, 6556.213254409501, 5945.286565612154, 6078.54410919174, 6081.878362432815, 6085.2393450818645, 6089.5737298388685, 3522.7534072615185, 3551.076720052805, 3554.644535546425, 3561.4301711726, 3562.1450851795385, 6809.931900681029, 6811.046453496514, 6811.727530898807, 6812.420944219797, 6820.863582728417, 6557.180352455943, 6685.732570697215, 6686.832829179212, 6691.76578819739, 6693.196816382066, 6762.69567869447, 6777.152855893013, 6787.966060169668, 6809.0, 6812.897806532906, 6308.432241098323, 6419.646919419477, 6474.870502590016, 6486.124373209556, 6513.413792758674, 6419.069234960811, 6439.323870993666, 6532.118164047793, 6535.3464653534265, 6535.607863528204, 6837.179538455417, 6850.897236541556, 6857.759978400732, 6862.622555759481, 6867.759628412981, 4389.056352884145, 4479.0593975264255, 4484.39460672818, 4486.618637415856, 4486.75322857246, 6586.1438013058, 6587.769428069994, 6587.80236592903, 6600.174978127734, 6601.867962640624, 6408.198975128109, 6417.518686098468, 6422.26143993428, 6423.293437721753, 6426.550141490238, 6235.96882015587, 6396.808095756948, 6408.775692850728, 6416.743330266924, 6417.97312430009, 6223.0, 6225.439710426083, 6262.561620686508, 6278.309385967448, 6279.874402512016, 6395.456386207038, 6418.839529011812, 6421.8073457796345, 6430.421262086435, 6437.839054023687, 6192.907106393318, 6275.623462592259, 6287.46556542699, 6288.27684816252, 6294.087357333069], "unit": "score", "name": "prototype.html", "value": 4788.123061588786}, {"lowerIsBetter": false, "replicates": [840.4411066640686, 856.9742907712767, 859.742077376787, 867.4838471109688, 871.7689812199773, 12508.874911250885, 12728.809067863978, 12730.554430594942, 12755.681107972305, 12790.616281511546, 12484.875151248485, 12559.0, 12559.37203139844, 12562.560310389139, 12579.685507862308, 670.4669787518934, 682.1439093937101, 820.429801288105, 825.7481468152196, 835.031363618203, 823.8928939237891, 830.2237408023487, 830.5265998380926, 830.9073568257721, 831.1273163178669, 818.6152508321079, 871.5859966515886, 876.4259410086404, 883.5449743382163, 886.3219636977717, 867.5705525764755, 873.6636394987912, 874.108409422392, 876.0888675777184, 877.385829919056, 517.4980269138929, 526.2185654303356, 527.9841604751864, 528.8254875890947, 528.8836455979716, 11665.533378664928, 11834.289942603471, 11901.285922844658, 11910.583129590423, 11917.702057448632, 11367.886321136766, 12384.442700078518, 12564.74870502594, 12570.182938108994, 12587.685307867285, 10151.137153341975, 10191.694249172537, 10328.948355258175, 10402.47987600617, 10737.83893241602, 3588.8385022674042, 3612.187257866959, 3618.6603681446404, 3652.3608368535665, 3686.502322186497, 46466.535334646556, 46517.0, 46569.767151164364, 46624.0, 46662.06675866498, 9349.485778282124, 9866.901330986599, 9899.0, 9980.900190998142, 10426.478676066166, 17103.74344384835, 17171.914140429468, 17247.310107595556, 17249.56876078083, 17273.39543115985, 7435.1449583297535, 7741.225877412214, 7852.725154619561, 7902.446828722049, 8031.919680803234, 4395.5280538698225, 4416.712913660666, 4450.710703804242, 4451.087527056946, 4465.866024019285, 2998.2654249708526, 3020.652624948159, 3036.635603727567, 3039.0578920534704, 3041.315703966634, 557.4731878374978, 565.4809063539881, 568.6105018062558, 576.8183022347947, 577.7977707802236, 663.8605892762478, 670.6311528659315, 672.3108813466237, 724.0876495615562, 724.6123324021623, 8092.190780921861, 8226.465279756796, 8278.627461764236, 8300.626471808782, 8421.452605580618, 529.407064088216, 543.8613153645795, 545.364650182533, 659.6899457255082, 684.1379861374604, 3815.9091136179227, 3933.783641899666, 3996.660283875845, 4018.9799051004557, 4069.084455997377, 49607.25589116166, 49840.0, 50587.0, 50642.74678626657, 50775.0, 46677.533224668, 48180.0, 48340.758296208995, 48584.757076214395, 48666.0, 43039.56960430356, 43407.13185736331, 43715.12569748587, 44104.558954410684, 44148.89627759268, 7809.492382995087, 7861.2531809478005, 7922.445428819928, 7966.3626909848235, 8132.878006829784, 32998.17504562405, 34333.0, 35365.646343537264, 35473.64526354807, 35590.64409355977, 41389.0, 41402.0, 42063.15873682448, 42443.3633495504, 42487.787561061996, 10263.435511046666, 10477.266591338534, 10496.527656255334, 10793.946030269799, 10820.134389248684, 11236.269642473213, 11313.71715707114, 11315.547378104784, 11327.603533876274, 11369.772604548029, 10525.89474105249, 10608.151347891995, 10610.363378197333, 10645.680629581126, 10658.73353166177, 10707.5181616829, 11199.60801371948, 11215.49530271156, 11238.381888996184, 11265.436728163722, 9192.264618830344, 9571.712848614552, 9835.114839664464, 10666.73333166646, 10997.780044398907, 8504.957475212832, 8590.78523036929, 8627.654893804178, 8800.823983520422, 8840.911590884009, 8609.009963854236, 8696.347773916856, 8853.07042760501, 8953.686620968236, 9057.456552606865], "unit": "score", "name": "yui.html", "value": 6075.8179156766655}], "name": "dromaeo_css", "value": 6858.179509328898}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 113.0, 111.0, 100.0, 113.0, 111.0, 118.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [158.0, 128.0, 155.0, 163.0, 124.0, 155.0, 146.0, 124.0, 161.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 144.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 162.0, 160.0, 162.0, 160.0, 164.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 88.0, 95.0, 70.0, 72.0, 72.0, 110.0, 89.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 148.0, 93.0, 95.0, 96.0, 140.0, 92.0, 93.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 197.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 151.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 61.0, 58.0, 56.0, 57.0, 58.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 83.0, 85.0, 85.0, 83.0, 93.0, 92.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 123.0, 121.0, 128.0, 119.0, 126.0, 120.0, 117.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [146.0, 153.0, 149.0, 152.0, 153.0, 143.0, 155.0, 151.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 69.0, 67.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1512.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [190.4036557501904], "unit": "score", "name": "DeltaBlue", "value": 347.251736}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1919.3857965451057], "unit": "score", "name": "RayTrace", "value": 385.5342689999999}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12204.819277108434], "unit": "score", "name": "Boyer", "value": 54.606543928923976}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [592.0663114268798], "unit": "score", "name": "Splay", "value": 137.63829900000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19884.38723969324}]} 05:01:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19884.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1512.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6858.18"}}} 05:01:39 INFO - Return code: 0 05:01:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:01:39 INFO - # TBPL SUCCESS # 05:01:39 INFO - Running post-action listener: _resource_record_post_action 05:01:39 INFO - Running post-run listener: _resource_record_post_run 05:01:40 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 568893440; Read time: 0; Write time: 968276 05:01:40 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 247721984; Read time: 0; Write time: 555276 05:01:40 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 321089536; Read time: 0; Write time: 412972 05:01:40 INFO - Running post-run listener: _upload_blobber_files 05:01:40 INFO - Blob upload gear active. 05:01:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:01:40 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 05:01:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:01:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:01:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:41 INFO - (blobuploader) - INFO - Done attempting. 05:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:01:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:01:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:01:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:01:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:01:42 INFO - (blobuploader) - INFO - Done attempting. 05:01:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:01:42 INFO - Return code: 0 05:01:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:01:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:01:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/928b8bfb832e33106f559965e3c0060e2bc9fba0abb2a93b0b65ad92c8907ca0bcd0284e86e59896140d26c9f1a719483217a55f308891375019149b2eb505dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/df3bf883d523318f9a985c73b041ef64f7c458cb8a73d3e852e279a5a31f34c69992b309a9a13bf5848709921521a422d7e09be354e9c7ff1e0ba14860dae7d1"} 05:01:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:01:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:01:42 INFO - Contents: 05:01:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/928b8bfb832e33106f559965e3c0060e2bc9fba0abb2a93b0b65ad92c8907ca0bcd0284e86e59896140d26c9f1a719483217a55f308891375019149b2eb505dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/df3bf883d523318f9a985c73b041ef64f7c458cb8a73d3e852e279a5a31f34c69992b309a9a13bf5848709921521a422d7e09be354e9c7ff1e0ba14860dae7d1"} 05:01:42 INFO - Copying logs to upload dir... 05:01:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.589784 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 05:01:38.512289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 05:01:38.515802) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/928b8bfb832e33106f559965e3c0060e2bc9fba0abb2a93b0b65ad92c8907ca0bcd0284e86e59896140d26c9f1a719483217a55f308891375019149b2eb505dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/df3bf883d523318f9a985c73b041ef64f7c458cb8a73d3e852e279a5a31f34c69992b309a9a13bf5848709921521a422d7e09be354e9c7ff1e0ba14860dae7d1"} build_url:https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/AMtv5F_RR-qP7TQW8nKzkw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/928b8bfb832e33106f559965e3c0060e2bc9fba0abb2a93b0b65ad92c8907ca0bcd0284e86e59896140d26c9f1a719483217a55f308891375019149b2eb505dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/df3bf883d523318f9a985c73b041ef64f7c458cb8a73d3e852e279a5a31f34c69992b309a9a13bf5848709921521a422d7e09be354e9c7ff1e0ba14860dae7d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-25 05:01:38.541045) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 05:01:38.541409) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451032018.487584-1375848652 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 05:01:38.624463) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 05:01:38.624802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 05:01:38.625110) ========= ========= Total master_lag: 0.22 =========