builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1456368031.29 results: success (0) buildid: 20160224155728 builduid: 9631e4bee30f4e00bb663ec47b0012dc revision: b9699111a9782e4c59fc318c7a68310b2ddce814 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.288241) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.288890) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.289364) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006775 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.313740) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.314251) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.336319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.336811) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.011653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.390868) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.391371) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.391980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.392448) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-24 18:40:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-02-24 18:40:31 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128450 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.538102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.538546) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.168613 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.718137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:31.718703) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9699111a9782e4c59fc318c7a68310b2ddce814 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b9699111a9782e4c59fc318c7a68310b2ddce814 --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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-24 18:40:31,761 truncating revision to first 12 chars 2016-02-24 18:40:31,761 Setting DEBUG logging. 2016-02-24 18:40:31,761 attempt 1/10 2016-02-24 18:40:31,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b9699111a978?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 18:40:32,038 unpacking tar archive at: mozilla-aurora-b9699111a978/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603531 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:32.337867) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:32.338225) ========= echo b9699111a9782e4c59fc318c7a68310b2ddce814 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b9699111a9782e4c59fc318c7a68310b2ddce814'] 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b9699111a9782e4c59fc318c7a68310b2ddce814 program finished with exit code 0 elapsedTime=0.003742 script_repo_revision: 'b9699111a9782e4c59fc318c7a68310b2ddce814' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:32.387272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:32.387604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 18:40:32.396548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-02-24 18:40:32.396864) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:40:32 INFO - MultiFileLogger online at 20160224 18:40:32 in /builds/slave/test-pgo 18:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:40:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:40:32 INFO - {'append_to_log': False, 18:40:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:40:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:40:32 INFO - 'branch': 'Mozilla-Aurora', 18:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:32 INFO - 'config_files': ('talos/linux_config.py',), 18:40:32 INFO - 'default_actions': ('clobber', 18:40:32 INFO - 'read-buildbot-config', 18:40:32 INFO - 'download-and-extract', 18:40:32 INFO - 'populate-webroot', 18:40:32 INFO - 'create-virtualenv', 18:40:32 INFO - 'install', 18:40:32 INFO - 'run-tests'), 18:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:32 INFO - 'download_minidump_stackwalk': True, 18:40:32 INFO - 'download_symbols': 'ondemand', 18:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:32 INFO - 'installer_path': 'installer.exe', 18:40:32 INFO - 'log_level': 'info', 18:40:32 INFO - 'log_name': 'talos', 18:40:32 INFO - 'log_to_console': True, 18:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:40:32 INFO - 'opt_config_files': (), 18:40:32 INFO - 'pip_index': False, 18:40:32 INFO - 'sps_profile': False, 18:40:32 INFO - 'sps_profile_interval': 0, 18:40:32 INFO - 'suite': 'dromaeojs-e10s', 18:40:32 INFO - 'system_bits': '32', 18:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:32 INFO - 'title': 'talos-linux64-ix-039', 18:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:32 INFO - 'use_talos_json': True, 18:40:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:32 INFO - 'work_dir': 'build'} 18:40:32 INFO - ##### 18:40:32 INFO - ##### Running clobber step. 18:40:32 INFO - ##### 18:40:32 INFO - Running pre-action listener: _resource_record_pre_action 18:40:32 INFO - Running main action method: clobber 18:40:32 INFO - rmtree: /builds/slave/test-pgo/build 18:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:40:33 INFO - Running post-action listener: _resource_record_post_action 18:40:33 INFO - ##### 18:40:33 INFO - ##### Running read-buildbot-config step. 18:40:33 INFO - ##### 18:40:33 INFO - Running pre-action listener: _resource_record_pre_action 18:40:33 INFO - Running main action method: read_buildbot_config 18:40:33 INFO - Using buildbot properties: 18:40:33 INFO - { 18:40:33 INFO - "project": "", 18:40:33 INFO - "product": "firefox", 18:40:33 INFO - "script_repo_revision": "production", 18:40:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:40:33 INFO - "repository": "", 18:40:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:40:33 INFO - "buildid": "20160224155728", 18:40:33 INFO - "pgo_build": "True", 18:40:33 INFO - "basedir": "/builds/slave/test-pgo", 18:40:33 INFO - "buildnumber": 155, 18:40:33 INFO - "slavename": "talos-linux64-ix-039", 18:40:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:40:33 INFO - "platform": "ubuntu64_hw", 18:40:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:40:33 INFO - "branch": "mozilla-aurora", 18:40:33 INFO - "repo_path": "releases/mozilla-aurora", 18:40:33 INFO - "revision": "b9699111a9782e4c59fc318c7a68310b2ddce814", 18:40:33 INFO - "stage_platform": "linux64-pgo", 18:40:33 INFO - "builduid": "9631e4bee30f4e00bb663ec47b0012dc", 18:40:33 INFO - "slavebuilddir": "test" 18:40:33 INFO - } 18:40:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 18:40:33 INFO - Running post-action listener: _resource_record_post_action 18:40:33 INFO - ##### 18:40:33 INFO - ##### Running download-and-extract step. 18:40:33 INFO - ##### 18:40:33 INFO - Running pre-action listener: _resource_record_pre_action 18:40:33 INFO - Running main action method: download_and_extract 18:40:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:40:33 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')]} 18:40:33 INFO - https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/test_packages.json 18:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/test_packages.json 18:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:40:38 INFO - Downloaded 1448 bytes. 18:40:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:40:38 INFO - Using the following test package requirements: 18:40:38 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:38 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:40:38 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:40:38 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'jsshell-linux-x86_64.zip'], 18:40:38 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:40:38 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:38 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:40:38 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:40:38 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:40:38 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:40:38 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:40:38 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:40:38 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:40:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:38 INFO - https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:40:45 INFO - Downloaded 23079376 bytes. 18:40:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:46 INFO - Return code: 0 18:40:46 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:46 INFO - https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:40:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:40:54 INFO - Downloaded 23079376 bytes. 18:40:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:55 INFO - Return code: 0 18:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:55 INFO - https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:40:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:40:57 INFO - Downloaded 10706572 bytes. 18:40:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 18:40:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 18:40:57 INFO - Return code: 0 18: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')]} 18:40:57 INFO - https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:40:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:40:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:40:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:40:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:40:59 INFO - Downloaded 59965095 bytes. 18:40:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:40:59 INFO - mkdir: /builds/slave/test-pgo/properties 18:40:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:40:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:40:59 INFO - Contents: 18:40:59 INFO - build_url:https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:41:00 INFO - Running post-action listener: _resource_record_post_action 18:41:00 INFO - Running post-action listener: set_extra_try_arguments 18:41:00 INFO - ##### 18:41:00 INFO - ##### Running populate-webroot step. 18:41:00 INFO - ##### 18:41:00 INFO - Running pre-action listener: _resource_record_pre_action 18:41:00 INFO - Running main action method: populate_webroot 18:41:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:41:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:41:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:41:00 INFO - '--tppagecycles', 18:41:00 INFO - '7'], 18:41:00 INFO - 'tests': ['tsvgm']}}, 18:41:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:41:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:41:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:41:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:41:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'tests': ['damp', 'tps']}, 18:41:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['damp', 'tps']}, 18:41:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:41:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:00 INFO - 'other': {'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'other_l64': {'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'other_nol64': {'tests': ['a11yr', 18:41:00 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'svgr': {'tests': ['tsvgx', 18:41:00 INFO - 'tsvgr_opacity', 18:41:00 INFO - 'tart', 18:41:00 INFO - 'tscrollx', 18:41:00 INFO - 'cart']}, 18:41:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tsvgx', 18:41:00 INFO - 'tsvgr_opacity', 18:41:00 INFO - 'tart', 18:41:00 INFO - 'tscrollx', 18:41:00 INFO - 'cart']}, 18:41:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'tests': ['tp5o']}, 18:41:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tp5o']}, 18:41:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--xperf_path', 18:41:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:00 INFO - 'tests': ['tp5n']}, 18:41:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s', 18:41:00 INFO - '--xperf_path', 18:41:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:00 INFO - 'tests': ['tp5n']}}, 18:41:00 INFO - 'talos.zip': {'path': '', 18:41:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:00 INFO - Running post-action listener: _resource_record_post_action 18:41:00 INFO - ##### 18:41:00 INFO - ##### Running create-virtualenv step. 18:41:00 INFO - ##### 18:41:00 INFO - Running pre-action listener: _resource_record_pre_action 18:41:00 INFO - Running main action method: create_virtualenv 18:41:00 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:41:00 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 18:41:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:41:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:00 INFO - Using real prefix '/usr' 18:41:00 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:41:01 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:03 INFO - Installing pip.................done. 18:41:03 INFO - Return code: 0 18:41:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18: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')]} 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:03 INFO - Using env: {'DISPLAY': ':0', 18:41:03 INFO - 'HOME': '/home/cltbld', 18:41:03 INFO - 'LANG': 'en_US.UTF-8', 18:41:03 INFO - 'LANGUAGE': 'en_US:en', 18:41:03 INFO - 'LOGNAME': 'cltbld', 18:41:03 INFO - 'MAIL': '/var/mail/cltbld', 18:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:03 INFO - 'MOZ_NO_REMOTE': '1', 18:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:03 INFO - 'NO_EM_RESTART': '1', 18:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:03 INFO - 'SHELL': '/bin/bash', 18:41:03 INFO - 'SHLVL': '1', 18:41:03 INFO - 'TERM': 'linux', 18:41:03 INFO - 'TMOUT': '86400', 18:41:03 INFO - 'USER': 'cltbld', 18:41:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:03 INFO - '_': '/tools/buildbot/bin/python'} 18:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:03 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 18:41:03 INFO - Cleaning up... 18:41:03 INFO - Return code: 0 18:41:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18: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')]} 18:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:03 INFO - Using env: {'DISPLAY': ':0', 18:41:03 INFO - 'HOME': '/home/cltbld', 18:41:03 INFO - 'LANG': 'en_US.UTF-8', 18:41:03 INFO - 'LANGUAGE': 'en_US:en', 18:41:03 INFO - 'LOGNAME': 'cltbld', 18:41:03 INFO - 'MAIL': '/var/mail/cltbld', 18:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:03 INFO - 'MOZ_NO_REMOTE': '1', 18:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:03 INFO - 'NO_EM_RESTART': '1', 18:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:03 INFO - 'SHELL': '/bin/bash', 18:41:03 INFO - 'SHLVL': '1', 18:41:03 INFO - 'TERM': 'linux', 18:41:03 INFO - 'TMOUT': '86400', 18:41:03 INFO - 'USER': 'cltbld', 18:41:03 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:03 INFO - '_': '/tools/buildbot/bin/python'} 18:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:03 INFO - Downloading/unpacking psutil>=0.7.1 18: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 18: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 18: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 18: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 18: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 18: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 18:41:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:05 INFO - Installing collected packages: psutil 18:41:05 INFO - Running setup.py install for psutil 18:41:05 INFO - building 'psutil._psutil_linux' extension 18:41:05 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 18:41:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:41:05 INFO - building 'psutil._psutil_posix' extension 18:41:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:41:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:41:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:06 INFO - Successfully installed psutil 18:41:06 INFO - Cleaning up... 18:41:06 INFO - Return code: 0 18:41:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:06 INFO - Using env: {'DISPLAY': ':0', 18:41:06 INFO - 'HOME': '/home/cltbld', 18:41:06 INFO - 'LANG': 'en_US.UTF-8', 18:41:06 INFO - 'LANGUAGE': 'en_US:en', 18:41:06 INFO - 'LOGNAME': 'cltbld', 18:41:06 INFO - 'MAIL': '/var/mail/cltbld', 18:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:06 INFO - 'MOZ_NO_REMOTE': '1', 18:41:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:06 INFO - 'NO_EM_RESTART': '1', 18:41:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:06 INFO - 'SHELL': '/bin/bash', 18:41:06 INFO - 'SHLVL': '1', 18:41:06 INFO - 'TERM': 'linux', 18:41:06 INFO - 'TMOUT': '86400', 18:41:06 INFO - 'USER': 'cltbld', 18:41:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:06 INFO - '_': '/tools/buildbot/bin/python'} 18:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:41:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:41:08 INFO - Installing collected packages: mozsystemmonitor 18:41:08 INFO - Running setup.py install for mozsystemmonitor 18:41:08 INFO - Successfully installed mozsystemmonitor 18:41:08 INFO - Cleaning up... 18:41:08 INFO - Return code: 0 18:41:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:41:08 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')]} 18:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:08 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')]} 18:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:08 INFO - Using env: {'DISPLAY': ':0', 18:41:08 INFO - 'HOME': '/home/cltbld', 18:41:08 INFO - 'LANG': 'en_US.UTF-8', 18:41:08 INFO - 'LANGUAGE': 'en_US:en', 18:41:08 INFO - 'LOGNAME': 'cltbld', 18:41:08 INFO - 'MAIL': '/var/mail/cltbld', 18:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:08 INFO - 'MOZ_NO_REMOTE': '1', 18:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:08 INFO - 'NO_EM_RESTART': '1', 18:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:08 INFO - 'SHELL': '/bin/bash', 18:41:08 INFO - 'SHLVL': '1', 18:41:08 INFO - 'TERM': 'linux', 18:41:08 INFO - 'TMOUT': '86400', 18:41:08 INFO - 'USER': 'cltbld', 18:41:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:08 INFO - '_': '/tools/buildbot/bin/python'} 18:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:09 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:10 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:41:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 INFO - Downloading docopt-0.6.1.tar.gz 18:41:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:11 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:11 INFO - Running setup.py install for blobuploader 18:41:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:41:11 INFO - Running setup.py install for requests 18:41:12 INFO - Running setup.py install for docopt 18:41:12 INFO - Successfully installed blobuploader requests docopt 18:41:12 INFO - Cleaning up... 18:41:12 INFO - Return code: 0 18:41:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 18:41:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 18:41:12 INFO - Using env: {'DISPLAY': ':0', 18:41:12 INFO - 'HOME': '/home/cltbld', 18:41:12 INFO - 'LANG': 'en_US.UTF-8', 18:41:12 INFO - 'LANGUAGE': 'en_US:en', 18:41:12 INFO - 'LOGNAME': 'cltbld', 18:41:12 INFO - 'MAIL': '/var/mail/cltbld', 18:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:12 INFO - 'MOZ_NO_REMOTE': '1', 18:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:12 INFO - 'NO_EM_RESTART': '1', 18:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:12 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:12 INFO - 'SHELL': '/bin/bash', 18:41:12 INFO - 'SHLVL': '1', 18:41:12 INFO - 'TERM': 'linux', 18:41:12 INFO - 'TMOUT': '86400', 18:41:12 INFO - 'USER': 'cltbld', 18:41:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:12 INFO - '_': '/tools/buildbot/bin/python'} 18:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:12 INFO - Running setup.py (path:/tmp/pip-tsfBLq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:12 INFO - Running setup.py (path:/tmp/pip-ABjpbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:12 INFO - Running setup.py (path:/tmp/pip-_I7cJI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:12 INFO - Running setup.py (path:/tmp/pip-b0FiKu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:12 INFO - Running setup.py (path:/tmp/pip-4pW1Pq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:12 INFO - Running setup.py (path:/tmp/pip-FD5amt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:12 INFO - Running setup.py (path:/tmp/pip-lj6BTB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:12 INFO - Running setup.py (path:/tmp/pip-snNG1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:12 INFO - Running setup.py (path:/tmp/pip-EYH5pL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:13 INFO - Running setup.py (path:/tmp/pip-imwkxG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:13 INFO - Running setup.py (path:/tmp/pip-AXCtS4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:13 INFO - Running setup.py (path:/tmp/pip-i1j0sM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:13 INFO - Running setup.py (path:/tmp/pip-i0kXen-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:13 INFO - Running setup.py (path:/tmp/pip-EqVuln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:13 INFO - Running setup.py (path:/tmp/pip-ABKEUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:13 INFO - Running setup.py (path:/tmp/pip-_FGA_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:13 INFO - Running setup.py (path:/tmp/pip-8bLTkw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:13 INFO - Running setup.py install for manifestparser 18:41:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:41:13 INFO - Running setup.py install for mozcrash 18:41:13 INFO - Running setup.py install for mozdebug 18:41:13 INFO - Running setup.py install for mozdevice 18:41:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozfile 18:41:14 INFO - Running setup.py install for mozhttpd 18:41:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozinfo 18:41:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozInstall 18:41:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozleak 18:41:14 INFO - Running setup.py install for mozlog 18:41:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for moznetwork 18:41:14 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozprocess 18:41:14 INFO - Running setup.py install for mozprofile 18:41:14 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:41:14 INFO - Running setup.py install for mozrunner 18:41:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:41:15 INFO - Running setup.py install for mozscreenshot 18:41:15 INFO - Running setup.py install for moztest 18:41:15 INFO - Running setup.py install for mozversion 18:41:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:41:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:15 INFO - Cleaning up... 18:41:15 INFO - Return code: 0 18:41:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:15 INFO - Using env: {'DISPLAY': ':0', 18:41:15 INFO - 'HOME': '/home/cltbld', 18:41:15 INFO - 'LANG': 'en_US.UTF-8', 18:41:15 INFO - 'LANGUAGE': 'en_US:en', 18:41:15 INFO - 'LOGNAME': 'cltbld', 18:41:15 INFO - 'MAIL': '/var/mail/cltbld', 18:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:15 INFO - 'MOZ_NO_REMOTE': '1', 18:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:15 INFO - 'NO_EM_RESTART': '1', 18:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:15 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:15 INFO - 'SHELL': '/bin/bash', 18:41:15 INFO - 'SHLVL': '1', 18:41:15 INFO - 'TERM': 'linux', 18:41:15 INFO - 'TMOUT': '86400', 18:41:15 INFO - 'USER': 'cltbld', 18:41:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:15 INFO - '_': '/tools/buildbot/bin/python'} 18:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:15 INFO - Running setup.py (path:/tmp/pip-ucbj4p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:41:15 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)) 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:15 INFO - Running setup.py (path:/tmp/pip-2M2vrM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:41:15 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)) 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:15 INFO - Running setup.py (path:/tmp/pip-pMFGzT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:41:15 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)) 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:15 INFO - Running setup.py (path:/tmp/pip-PPpRgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:15 INFO - Running setup.py (path:/tmp/pip-lgz0BX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:41:15 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)) 18:41:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:15 INFO - Running setup.py (path:/tmp/pip-u2Z2I2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:16 INFO - Running setup.py (path:/tmp/pip-YN17Sz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:16 INFO - Running setup.py (path:/tmp/pip-WKMWHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:16 INFO - Running setup.py (path:/tmp/pip-4DBPC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:16 INFO - Running setup.py (path:/tmp/pip-LgjQfg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:16 INFO - Running setup.py (path:/tmp/pip-2gYIPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:16 INFO - Running setup.py (path:/tmp/pip-a7qCSt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:16 INFO - Running setup.py (path:/tmp/pip-Rxfan7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:16 INFO - Running setup.py (path:/tmp/pip-eYapnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:16 INFO - Running setup.py (path:/tmp/pip-4cAu9m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:16 INFO - Running setup.py (path:/tmp/pip-g0etzF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:41:16 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)) 18:41:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:16 INFO - Running setup.py (path:/tmp/pip-LgfDId-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:41:16 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)) 18:41:16 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)) 18:41:16 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)) 18:41:16 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)) 18:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:18 INFO - Downloading blessings-1.6.tar.gz 18:41:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:18 INFO - Installing collected packages: blessings 18:41:18 INFO - Running setup.py install for blessings 18:41:18 INFO - Successfully installed blessings 18:41:18 INFO - Cleaning up... 18:41:18 INFO - Return code: 0 18:41:18 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:41:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:41:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:41:19 INFO - Reading from file tmpfile_stdout 18:41:19 INFO - Current package versions: 18:41:19 INFO - argparse == 1.2.1 18:41:19 INFO - blessings == 1.6 18:41:19 INFO - blobuploader == 1.2.4 18:41:19 INFO - docopt == 0.6.1 18:41:19 INFO - manifestparser == 1.1 18:41:19 INFO - mozInstall == 1.12 18:41:19 INFO - mozcrash == 0.16 18:41:19 INFO - mozdebug == 0.1 18:41:19 INFO - mozdevice == 0.48 18:41:19 INFO - mozfile == 1.2 18:41:19 INFO - mozhttpd == 0.7 18:41:19 INFO - mozinfo == 0.9 18:41:19 INFO - mozleak == 0.1 18:41:19 INFO - mozlog == 3.1 18:41:19 INFO - moznetwork == 0.27 18:41:19 INFO - mozprocess == 0.22 18:41:19 INFO - mozprofile == 0.28 18:41:19 INFO - mozrunner == 6.11 18:41:19 INFO - mozscreenshot == 0.1 18:41:19 INFO - mozsystemmonitor == 0.0 18:41:19 INFO - moztest == 0.7 18:41:19 INFO - mozversion == 1.4 18:41:19 INFO - psutil == 3.1.1 18:41:19 INFO - requests == 1.2.3 18:41:19 INFO - wsgiref == 0.1.2 18:41:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:19 INFO - Using env: {'DISPLAY': ':0', 18:41:19 INFO - 'HOME': '/home/cltbld', 18:41:19 INFO - 'LANG': 'en_US.UTF-8', 18:41:19 INFO - 'LANGUAGE': 'en_US:en', 18:41:19 INFO - 'LOGNAME': 'cltbld', 18:41:19 INFO - 'MAIL': '/var/mail/cltbld', 18:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:19 INFO - 'MOZ_NO_REMOTE': '1', 18:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:19 INFO - 'NO_EM_RESTART': '1', 18:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:19 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:19 INFO - 'SHELL': '/bin/bash', 18:41:19 INFO - 'SHLVL': '1', 18:41:19 INFO - 'TERM': 'linux', 18:41:19 INFO - 'TMOUT': '86400', 18:41:19 INFO - 'USER': 'cltbld', 18:41:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:19 INFO - '_': '/tools/buildbot/bin/python'} 18:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 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)) 18:41:19 INFO - Cleaning up... 18:41:19 INFO - Return code: 0 18:41:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:19 INFO - Using env: {'DISPLAY': ':0', 18:41:19 INFO - 'HOME': '/home/cltbld', 18:41:19 INFO - 'LANG': 'en_US.UTF-8', 18:41:19 INFO - 'LANGUAGE': 'en_US:en', 18:41:19 INFO - 'LOGNAME': 'cltbld', 18:41:19 INFO - 'MAIL': '/var/mail/cltbld', 18:41:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:19 INFO - 'MOZ_NO_REMOTE': '1', 18:41:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:19 INFO - 'NO_EM_RESTART': '1', 18:41:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:19 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:19 INFO - 'SHELL': '/bin/bash', 18:41:19 INFO - 'SHLVL': '1', 18:41:19 INFO - 'TERM': 'linux', 18:41:19 INFO - 'TMOUT': '86400', 18:41:19 INFO - 'USER': 'cltbld', 18:41:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:19 INFO - '_': '/tools/buildbot/bin/python'} 18:41:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:19 INFO - Downloading/unpacking jsonschema 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:21 INFO - Downloading/unpacking functools32 (from jsonschema) 18:41:21 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 18:41:21 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 18:41:21 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 18:41:21 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 18:41:21 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 18:41:21 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 18:41:21 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:21 INFO - warning: no files found matching '*.txt' 18:41:21 INFO - no previously-included directories found matching 'build' 18:41:21 INFO - no previously-included directories found matching 'dist' 18:41:21 INFO - no previously-included directories found matching '.git*' 18:41:21 INFO - Installing collected packages: jsonschema, functools32 18:41:21 INFO - Running setup.py install for functools32 18:41:21 INFO - warning: no files found matching '*.txt' 18:41:21 INFO - no previously-included directories found matching 'build' 18:41:21 INFO - no previously-included directories found matching 'dist' 18:41:21 INFO - no previously-included directories found matching '.git*' 18:41:21 INFO - Successfully installed jsonschema functools32 18:41:21 INFO - Cleaning up... 18:41:21 INFO - Return code: 0 18:41:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f07c42d2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b4d360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, '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': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', '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 18:41:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 18:41:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 18:41:21 INFO - Using env: {'DISPLAY': ':0', 18:41:21 INFO - 'HOME': '/home/cltbld', 18:41:21 INFO - 'LANG': 'en_US.UTF-8', 18:41:21 INFO - 'LANGUAGE': 'en_US:en', 18:41:21 INFO - 'LOGNAME': 'cltbld', 18:41:21 INFO - 'MAIL': '/var/mail/cltbld', 18:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:21 INFO - 'MOZ_NO_REMOTE': '1', 18:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:21 INFO - 'NO_EM_RESTART': '1', 18:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:21 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:21 INFO - 'SHELL': '/bin/bash', 18:41:21 INFO - 'SHLVL': '1', 18:41:21 INFO - 'TERM': 'linux', 18:41:21 INFO - 'TMOUT': '86400', 18:41:21 INFO - 'USER': 'cltbld', 18:41:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:21 INFO - '_': '/tools/buildbot/bin/python'} 18:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:22 INFO - Downloading/unpacking flake8 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:41:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:41:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:24 INFO - no previously-included directories found matching 'docs/_build' 18:41:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:41:24 INFO - Running setup.py install for pep8 18:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:41:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:41:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:41:24 INFO - no previously-included directories found matching 'docs/_build' 18:41:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:41:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:41:24 INFO - Cleaning up... 18:41:24 INFO - Return code: 0 18:41:24 INFO - Running post-action listener: _resource_record_post_action 18:41:24 INFO - Running post-action listener: _start_resource_monitoring 18:41:24 INFO - Starting resource monitoring. 18:41:24 INFO - ##### 18:41:24 INFO - ##### Running install step. 18:41:24 INFO - ##### 18:41:24 INFO - Running pre-action listener: _resource_record_pre_action 18:41:24 INFO - Running main action method: install 18:41:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:41:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:41:25 INFO - Reading from file tmpfile_stdout 18:41:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:41:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:41:25 INFO - Reading from file tmpfile_stdout 18:41:25 INFO - Output received: 18:41:25 INFO - Usage: mozinstall [options] installer 18:41:25 INFO - Options: 18:41:25 INFO - -h, --help show this help message and exit 18:41:25 INFO - -d DEST, --destination=DEST 18:41:25 INFO - Directory to install application into. [default: 18:41:25 INFO - "/builds/slave/test-pgo"] 18:41:25 INFO - --app=APP Application being installed. [default: firefox] 18:41:25 INFO - mkdir: /builds/slave/test-pgo/build/application 18:41:25 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:41:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:41:40 INFO - Reading from file tmpfile_stdout 18:41:40 INFO - Output received: 18:41:40 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:41:40 INFO - Running post-action listener: _resource_record_post_action 18:41:40 INFO - ##### 18:41:40 INFO - ##### Running run-tests step. 18:41:40 INFO - ##### 18:41:40 INFO - Running pre-action listener: _resource_record_pre_action 18:41:40 INFO - Running main action method: run_tests 18:41:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:41:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:41:40 INFO - Python 2.7.3 18:41:40 INFO - Return code: 0 18:41:40 INFO - grabbing minidump binary from tooltool 18:41:40 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')]} 18:41:40 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 0x2bdc540>, '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 0x2bdd440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:41:40 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 18:41:40 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 18:41:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:40 INFO - Return code: 0 18:41:40 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:41:40 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:41:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:41:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:41:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:41:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:41:41 INFO - Return code: 0 18:41:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:41:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:41:41 INFO - Using env: {'DISPLAY': ':0', 18:41:41 INFO - 'HOME': '/home/cltbld', 18:41:41 INFO - 'LANG': 'en_US.UTF-8', 18:41:41 INFO - 'LANGUAGE': 'en_US:en', 18:41:41 INFO - 'LOGNAME': 'cltbld', 18:41:41 INFO - 'MAIL': '/var/mail/cltbld', 18:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:41 INFO - 'MOZ_NO_REMOTE': '1', 18:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:41 INFO - 'NO_EM_RESTART': '1', 18:41:41 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:41:41 INFO - 'PWD': '/builds/slave/test-pgo', 18:41:41 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:41:41 INFO - 'SHELL': '/bin/bash', 18:41:41 INFO - 'SHLVL': '1', 18:41:41 INFO - 'TERM': 'linux', 18:41:41 INFO - 'TMOUT': '86400', 18:41:41 INFO - 'USER': 'cltbld', 18:41:41 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368', 18:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:41 INFO - '_': '/tools/buildbot/bin/python'} 18:41:41 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:41:41 INFO - mozversion application_buildid: 20160224155728 18:41:41 INFO - mozversion application_changeset: b9699111a9782e4c59fc318c7a68310b2ddce814 18:41:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:41:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:41 INFO - mozversion application_name: Firefox 18:41:41 INFO - mozversion application_remotingname: firefox-dev 18:41:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:41 INFO - mozversion application_vendor: Mozilla 18:41:41 INFO - mozversion application_version: 46.0a2 18:41:41 INFO - mozversion platform_buildid: 20160224155728 18:41:41 INFO - mozversion platform_changeset: b9699111a9782e4c59fc318c7a68310b2ddce814 18:41:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:41:41 INFO - mozversion platform_version: 46.0a2 18:41:41 INFO - using testdate: 1456368101 18:41:41 INFO - actual date: 1456368101 18:41:41 INFO - starting webserver on 'localhost:57428' 18:41:41 INFO - SUITE-START | Running 3 tests 18:41:41 INFO - TEST-START | dromaeo_css 18:41:41 INFO - operating with platform_type : linux_ 18:41:41 INFO - Initialising browser for dromaeo_css test... 18:41:41 INFO - TEST-INFO | started process 7025 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0vLjFI/profile http://localhost:57428/getInfo.html) 18:41:45 INFO - PROCESS | 7025 | 18:41:45 INFO - PROCESS | 7025 | (process:7104): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:41:46 INFO - PROCESS | 7025 | __metrics Screen width/height:1600/1200 18:41:46 INFO - PROCESS | 7025 | colorDepth:24 18:41:46 INFO - PROCESS | 7025 | Browser inner width/height: 1024/697 18:41:46 INFO - PROCESS | 7025 | __metrics 18:41:47 INFO - TEST-INFO | 7025: exit 0 18:41:47 INFO - Browser initialized. 18:41:47 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:47 INFO - TEST-INFO | started process 7153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0vLjFI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:49 INFO - PROCESS | 7153 | 18:41:49 INFO - PROCESS | 7153 | (process:7218): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:41:59 INFO - PROCESS | 7153 | RSS: Main: 140611584 18:41:59 INFO - PROCESS | 7153 | 18:42:49 INFO - PROCESS | 7153 | 1456368169375 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] 18:44:57 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57428/tests/dromaeo/cssquery-ext.html) 18:44:58 INFO - PROCESS | 7153 | RSS: Main: 145997824 18:44:58 INFO - PROCESS | 7153 | 18:48:00 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-ext.html (next: http://localhost:57428/tests/dromaeo/cssquery-jquery.html) 18:48:01 INFO - PROCESS | 7153 | RSS: Main: 144429056 18:48:01 INFO - PROCESS | 7153 | 18:51:03 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57428/tests/dromaeo/cssquery-mootools.html) 18:51:03 INFO - PROCESS | 7153 | RSS: Main: 143331328 18:51:03 INFO - PROCESS | 7153 | 18:54:05 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57428/tests/dromaeo/cssquery-prototype.html) 18:54:05 INFO - PROCESS | 7153 | RSS: Main: 143335424 18:54:05 INFO - PROCESS | 7153 | 18:57:08 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57428/tests/dromaeo/cssquery-yui.html) 18:57:08 INFO - PROCESS | 7153 | RSS: Main: 143253504 18:57:08 INFO - PROCESS | 7153 | 19:00:10 INFO - PROCESS | 7153 | Cycle 1(1): loaded http://localhost:57428/tests/dromaeo/cssquery-yui.html (next: http://localhost:57428/tests/dromaeo/cssquery-dojo.html) 19:00:11 INFO - PROCESS | 7153 | RSS: Main: 146710528 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | __start_tp_report 19:00:11 INFO - PROCESS | 7153 | _x_x_mozilla_page_load 19:00:11 INFO - PROCESS | 7153 | _x_x_mozilla_page_load_details 19:00:11 INFO - PROCESS | 7153 | |i|pagename|runs| 19:00:11 INFO - PROCESS | 7153 | |0;dojo.html;3385.322935412917;3421.3670470962875;3425.297813948141;3436.82815859207;3447.0520606833124;5540.501354878055;5541.833744987647;5562.3047119110115;5595.356533998586;5613.2141500189955;5553.7778488860495;5558.749856256478;5568.470995255454;5577.832665020046;5613.045782217023;4972.544081863107;5011.423686276079;5068.290439338495;5134.460881607433;5163.122269214243;5044.218146187329;5047.167217409123;5095.439501654815;5129.948700512984;5167.199084141964;5177.275181474578;5237.371515418136;5247.553957913563;5261.76322065508;5267.446918073604;5146.9485305146845;5152.562032227265;5179.7928082877015;5186.24799404088;5213.113770658978;4972.8508144755715;4998.875028124289;5036.672616279967;5084.339035925306;5110.9744451277875;5261.394939581921;5269.710165940872;5300.019496393141;5309.761060752276;5318.680879147263;5905.704714764244;5956.702164891738;5964.403559644044;5970.492508136814;5981.282246130449;5943.881122377571;5979.970100149515;5983.521318294526;5994.7901823436405;6117.888303246575;5691.3170419549915;5696.971515142398;5701.25883635129;5704.2299289595785;5716.428357164292;6195;6200.875982480326;6213.937860621426;6221.657808820558;6241.375862413813;5748.597598168171;5772.076467765138;5936.881262374728;5962.433568810956;6023.066424704178;6080.69596520181;6090.969545152246;6099.969500152471;6106.992346262906;6119.755209791559;5958;5980.282366116007;5993.190919225849;6004.729787159588;6005.219321488266;5848.590598658053;5918.289805223315;5945.464908158287;5951.196588460502;6029.638221706711;4494.921218907504;4511.390962220124;4532.7280363178315;4548.31775233711;4565.7717114144825;4088.1210539733506;4099.549049604541;4101.282275601758;4114.19773144234;4122.299209134454;5514.531264842453;5601.6358936668985;5686.289213848269;5722.313322401338;5735.3977832327;5982.521398288213;6077.179580756541;6077.726502307407;6081.27024757032;6087.786927457518;5467.781288748485;5688.63023903445;5706.543476521868;5710.65736055838;5720.2849643794525;5008.4240312364545;5033.370828646419;5037.924431133536;5047.87380315495;5059.266406371129;6095.847603809941;6178.505719542426;6203.503719702413;6260.436560709558;6274.341194174637;5991.191189189403;5998.070299103646;6012.549058820693;6023.3073196582955;6051.848703782441;5942.168096466412;6068.9089663654195;6125.081237814185;6169.136320915165;6184.938150618436;5844.035734103825;5975.850603734942;6047.002244629763;6050.848728781815;6073.605215660968;6032.4570788629235;6037.486813620716;6057.1519987200945;6057.485113765203;6062.454379105725;5763.36602973681;5841.795537156179;5863.941360586339;5893.263342082239;5896.086106653475;5799.188113664006;5918.940810591839;5994.10088486713;6010.699465026643;6041.78853740117;5825.3883342248455;5844.2986841577585;5844.327902291121;5845.678487683218;5852.561057920758;5787.479126878601;5825.126231065374;5966.105084237399;5967.403259674172;5979.940200598112;5651.745671444713;5792.94207057924;5890.734916928663;5894.941050589439;5929.6145750526075 19:00:11 INFO - PROCESS | 7153 | |1;ext.html;563.2002556369954;566.5071387892534;580.6342004537141;585.6193474241742;591.6923199936033;37293.81353093234;38387.61612383875;38586;38599.421008684825;38604.420933686015;42744;42895.14209715812;43171.784141079326;43174;43214.567854321525;8660.566971651424;8847;8870.822583548357;8871.822563548725;8884.73345799627;8631.525266110362;8751.824963500727;8783.209511143996;8995.865062024075;9002.909970900306;8848.823023539526;9015.504147271897;9017;9018.05310442404;9034.05142460042;8915.42049766763;8931.866022009675;8972.955135224347;8981.685641002567;8981.775455613564;8694.39139260252;8848.690295839679;8886.422382545114;8889.644414223423;8891.86662200061;41476.792616037026;41719.374209386886;42126.78936605328;42328.576714232775;42364.364534532004;3578.982105089484;3799.204840793554;3802.6007269236884;4252.213340532012;4340.175366680321;32484;32530.83734581312;32804.507932381035;32984;33206.501902471486;4189.539150693421;4291.678124140671;4306.160298741715;4307.91384172318;4332.1985432695055;288621;289791.9999999979;290420;291131;291942;44396.3340549892;45209.77395113003;45217.54782452133;45237.32144017842;45328.3200751989;43831;43949.56050439519;44064.77967610142;44075.559244407144;44291.778541107735;16539.25573349202;16593.83406165947;16628.168591570615;16718.58203544921;16747.33010679559;13352.198868067948;13388.799168012487;13448.93275533616;13608.183508989492;13802.792958105636;15330.310136043905;15394.846051539342;15517.922410388102;15608.141552214738;15714.842851571566;6021.217241758631;6126.142340072393;6201.627902325875;6262.5929314594405;6282.434580887742;1082.7076689293847;1136.6078702847503;1169.5204965964085;1203.1638011581867;1219.318136611357;31103.533446998314;32508.349833003682;33186.50220246698;33240.667593324244;33241.66758332434;1130.5025788653131;1135.8807325230732;1174.4949671641277;1180.4392913366255;1219.268438936631;16393.83606163947;16507.66984660324;16550.83449165493;16557.751633725504;16615.750763738553;499432;503762;508840;510623;777959;59932.400675992685;60358;60414.39585604176;60415;60585.394146058854;1512.954611361661;1540.6225474758533;1550.9069455832687;1552.534239728077;1558.2364641325669;32396.67603324031;32515.51226731648;32823.83588082044;32882.835585821915;33577.83211083929;50108.74945625249;50623.49376506188;50640.49359506358;50699.493005069475;50711.746441267554;312513;312998;313116;314600;314893;34996;35123.47314790229;35543;35871.82064089663;36022.819885900404;45609.087818244116;45968.31047534223;46197.53802462067;47041.52958470371;47319.29021064618;43503;44432;45914.540854591025;46088.308675370565;46657;39082;39521.73307050472;39538;39942.80028599838;40120.1975960485;40093.79953100216;40192.1961560773;40569.1886162281;40582.79708601438;40958.38562421626;36205.0948726284;37339.813300933325;37876.242475150895;38353.80823095867;38538.80730596329;25953.22140335793;27962.72037279601;28038.579421309103;28234.2941426466;28255.858720706266 19:00:11 INFO - PROCESS | 7153 | |2;jquery.html;362.7678285897026;372.6888048479519;376.3996425701006;383.8291960077765;404.749324587026;15531.68936621267;17023.40418085367;17442.30230790767;18893.905530472344;18919.621607567857;11173.21787474877;17208.39770608029;17373.82626173738;17597.3840915568;17915.552111197194;5171.974140129303;5190.325257716491;5292.259083728281;5310.283111779918;5311.9468805312035;4014.2774300625874;4143.067809742814;5213.400458947212;5265.420803711589;5594.160875868612;5701.486866182064;5749.827505174831;5751.884962300752;5783.36382997872;5794.333651630053;6500.382463665944;6700.497462690269;6736.528443008967;6804.897926531056;6806.421454176401;6362.331955144736;6496.480281577463;6538.705758240843;6645;6664.800055998279;23231.883840580856;23811.285661430185;24532.632010519857;24569.38576535583;24646.507069858682;2366.148186652804;2436.707595088583;2453.7423570525193;2495.438526331579;2511.234073607549;14362.210078445682;14771.852281477155;14991.32539035746;15014.474493392789;15239.390424383011;2002.9799702003086;2014.9697754533693;2096.790320967906;2118.692789545523;2132.8826914519695;64857;66095.66952165257;67662;68040;68213.31786682119;15877.761833572506;16096.11471369086;16141.757873631905;16179.83820161807;16452.4241651544;25085.87457062703;25189.370265743502;25313.114041008477;25519.489610207693;25570.23289301324;7869.606519673994;8183.345332373396;8227.794305142299;8258.669653213925;8286.047104582929;7931;7931.524108553505;7969.362451004022;8021.679132834738;8065.233802788725;4295.8281668733525;4344.9348259776125;4397.758123303185;4415.757133357696;4452.577005184502;1850.4911149434013;1934.3713293179774;1942.77658069321;1959.9902000489906;1969.084375765276;983.8032393521324;1085.1427372375892;1100.944952752359;1110.6667999600088;1139.8062329404022;17013.914930425268;17595.29618815233;17629.55926101832;17950.281988720566;17973.37093201732;1054.862867827193;1067.4876059491487;1067.514281002142;1072.4905669806778;1180.3154170581042;10188.134008609351;10367.170626350025;10409.53157107932;10435.269531132748;10478.685639430829;544527;557125;559670;562994;567039;69699;70225.64887175531;70263.64868175627;72227.63886180536;72491.63754181196;1188.857337119534;1191.3745283726114;1239.1821397877359;1243.9689007774878;1261.4008346035744;16161.27274272637;16161.67676646484;16165.110918899574;16197.109158996369;16316.67366652684;32740.181495462803;32880.67119328776;33824.323513530086;34001;34112.65887341095;43126.56873431351;43995.78002110097;44233.33649995188;44319.33520997123;44365.33451998158;7102;7162.176349719849;7207.063081799332;7381.7416390428225;7393.889091663522;8879.268542634125;10934.507947142238;10958.342499450058;11106.777864442503;11299;10416.635417760343;10576.524056417325;10771.13830893511;11008.229423940247;11140.888591113986;10557.313774604627;10614.522346494581;10903.836442453528;10906.836397453886;10985.450727463754;10774.515146818256;11040.392778396945;11114.110871130451;11188.888111118784;11367.31796092204;7197.640117993975;7221.638918053971;7490.101187857274;7585;7658.502197357154;10288.639897603547;10331.793364132525;10404.68785936423;10483.475826208507;10530 19:00:11 INFO - PROCESS | 7153 | |3;mootools.html;1455.7234125516152;1486.8513148685133;1691.864650827934;1830.1306879232359;1848.8520918326535;8100.230478104585;8252.628631711572;8310.542920139398;8403.243708066273;8444.408891377607;8388.66445342187;8461.576921153934;8474.364422668294;8480.703175388862;8485.236328730412;2456.3613460500264;2464.963025554609;2465.938351541208;2478.10788116278;2480.3923038855505;2476.6904136982876;2547.1721690450586;2547.7070136934212;2549.974500254992;2554.8722563871825;2427.3567504611206;2470.1601455505124;2482.168473561359;2496.1762618335997;2530.0891678995545;2444.49887773007;2456.7788898999174;2470.72821989581;2470.950580988388;2471.542764588548;2412.4089598048413;2418.6734790803193;2423.7212720537186;2432.3797431654816;2443.5601591713485;8030.156833532454;8053.557054362008;8135;8142.267195952392;8152.470089444227;4916.778744956449;5147.279380886679;5189.610779191576;5211.296474975906;5227.660202086852;3180.761442891769;3288.9506657400157;3324.484704870749;3357.261402491448;3378.881739139143;1064.4571268652965;1088.357868857378;1117.9888201117967;1134.8921852424007;1153.9596114135966;11501.194916355858;11688;11703.941480292544;11709.824352634718;11735.295882247092;4419.049904270597;4547.226971414867;4549.385832912514;4563.224251877189;4568.428946381702;9523.714288571355;9539.952300238594;9557.474338911426;9567.138957493858;9578;5061.721605311744;5065.645404821627;5073.441921388644;5128.7179205144075;5131.409887862869;4684.016356565091;4689.390379250675;4697.694649847749;4706.411698537683;4706.458757242961;3698.9445158322646;3739.6821270191795;3748.700103991674;3756.5912782706487;3773;1119.261287550213;1125.352922069813;1129.9774004519863;1132.9546818127183;1155.8555180602425;1065.8614380130534;1110.8666959964694;1178.2753606532092;1211.4064108586729;1359.0609038501811;7471.551706897603;7586.127595326498;7603.2776886195725;7617.047869016373;7654.196309387546;1113.6269349767917;1180.7874582575218;1191.988080119205;1210.4673943464848;1224.908131890112;5977.432143946318;5981.37195594465;5981.551383646244;6003.8198854034445;6030.33666296707;10081.243906707026;10336.431496267778;10340.844887326695;10345.741356465998;10495.842562361571;10059.798804023878;10092.949535252277;10233.539490722935;10261;10306.639267625747;7930.603469826601;8043.276105150681;8061.435699500978;8070.2333278338465;8097.676092956333;7501.962490187514;7529.736459223901;7624.504407213513;7635;7663.961680191564;8712.520811355183;8837.823243535222;9159.862602061108;9215.124563166488;9228.35401521887;8987.550622468982;9126.863097053681;9204.125608067223;9258.675946341846;9406.717798466058;7498.925010749823;7641.847163056596;7660.578668173304;7663.195364486649;7670.616469176631;7954.284114429498;8061.717839875576;8067.838643226985;8108.067572229269;8112.918870811216;7649.388048955959;7682.884756728766;7756.457048006585;7797.688092476237;7840.72557460509;7360;7428.702851885864;7458.627068646438;7529.887051694339;7804.531728096333;7559.697612095454;7576.166621671501;7609.581473018816;7624.58064806441;7674.6162691864065;7031.929680703128;7044.189918159477;7071.222165561887;7099.183593886769;7113.57318560888;7038.542494737826;7081.575105493687;7108.786736397917;7109.537880037781;7155.284471552803 19:00:11 INFO - PROCESS | 7153 | |4;prototype.html;371.40389674572316;379.2888334373051;381.45261549676206;382.71870175421077;387.4266086192435;6385.0741642461935;6424.839379015527;6435.742570297189;6436.452901503372;6608.207015158176;6393.808185754423;6422.9357706422925;6428.710708018139;6441.227052753676;6449.258335291443;4950.504949505057;4951.2573114033;4960.429550601691;4962.478939711333;4967.50324967504;4946.332245146895;4949.7030178189425;4959.776810043539;4971.005798840229;4980.252962055684;4780.617550595944;4885.2427873679635;4914.213725803872;4915.262710593403;4918.483559226283;4876.487968763265;4886.706797592155;4901.362822833027;4914.066327397783;4914.606831453493;4304.096139810644;4312.3531470279395;4313.396124542566;4317.417148684919;4322.589354011364;6023.066424704178;6071.423214794588;6107.816765497042;6113.847153821145;6130.63216207029;5722.971385143048;5764.452377024176;5778.133280007991;5779.381773103496;5783;6850.588964662086;6878.38094571486;6884.48366372519;6894.276101009372;6902.516823822334;4758.809647614091;4773.4510531289;4786.1863483207935;4787.473377928425;4791.6406269529925;6969.372756451944;7076.610786406745;7113.430925525997;7158.99774031636;7166.355028047448;4911.803527858846;4918.286848406961;4920.114379411669;4923.138450771101;4923.261510773413;4973.055119527278;4981.128302547112;4990.80036798524;4992.026554821775;4993;5542.418046105182;5707.315122185364;5721.685307308138;5743.770249190069;5744.655320680772;6872.793816185523;6879;6898.448124150056;6915;6921.861562768717;1714.374253397501;1749.0817320906372;1770.0353307447472;1770.9026003569927;1771.4419957713278;1156.3582211872324;1175.353555544447;1187.0088476122362;1190.4940400329824;1192.356127691037;6466.094746735461;6490.448311893448;6505.349465053551;6510.7721229756735;6522.184726909137;6963.895541566881;6981.2669669684965;7006.649667516705;7024.964875175591;7066.470014748915;6402.551821372459;6427.389398007182;6452.451541619015;6495.3179916109075;6514.739410423625;3797.7721336719887;3803.5435747710453;3820.3696390095324;3825.387937929918;3829.215010922754;7081.327273908971;7144.821379465555;7150.785476435715;7168.2831716827895;7174.139103307532;6922.446204303644;7138.964305178441;7146.32109949554;7154.284571542804;7196.784096477114;7139.071920650283;7140.285971402818;7143.142822861186;7155.3202445767565;7161.92838071623;6946.16646002483;6978.232394436709;6979.057827193467;7001.579905205704;7034.366906978396;6747.865042699021;6801.829954251183;6837.965810170917;6841.760538381132;6843.213030501556;7072.186698529735;7112.217656057726;7124.964375178299;7141.535800172972;7149.964250178716;4886.071646387175;4910.337104490848;4917.508249175054;4925.655204135819;4930.112579735539;6867.965660171867;6988.685509152202;6995.825104372431;7010.614416206953;7012.964935175291;6768.96615516939;6776.322367763184;6787.66061696923;6808.080909077211;6828;6759.222689390783;6780.660966951534;6782.93217067823;6788.7284508619105;6810.455163586802;6486.156799616208;6663.466922646274;6678.766243181465;6691.063251144747;6696.229933557704;6765.560238584476;6777.762778302736;6806.285340039422;6835.555688880207;6857.177138743184;6668.599884006975;6683.231428385603;6695.296993815774;6697.497687673346;6699.732010719516 19:00:11 INFO - PROCESS | 7153 | |5;yui.html;925.5557332480411;932.426557667035;940.2055263302511;947.8815148106487;949.6960972488806;13501.32493375331;13771.586852394432;13812.723745525083;13819.585412437618;14814.777778333333;14208.786868196985;14264;14286.071405358645;14296.285185740697;14349.426022959069;784.051297929506;793.5754371411296;871.3377832847034;876.6843936182969;891.7993451473432;864.8486514859875;874.204473928725;875.9562021898911;879.9252063574604;880.4981160738382;927.9072092790734;931.818295432391;937.3813283233068;937.7936853892132;939.9389039712397;923.676713150392;925.8287216864901;927.7587827164951;928.3501548915785;935.1163150822475;685.9451243900476;687.6630451078935;687.8727435424463;689.7206631314326;690.6857379892137;14829.629259268604;14925.626859328495;14965.775513367309;15042.548723538312;15061.774073388908;14027.929860350734;14062.859371406359;14086.15483071019;14261.928690356586;14287.714245715131;10756.73108172294;10803.297785643987;10913.618023369223;11103.888961110366;11867.228630139014;4596.218642830727;4626.58360747531;4670.182718024332;4691.507391723854;4805.783739731685;53250.73374633141;53275.46724532744;54012.729936350064;54106.458935410534;54201.1869821953;11161.386123763108;11225.438728063564;11229.3262404256;11252.381119038368;11543.19197656156;18769.436916892515;18831;18832.24671013144;18954.81045189558;18980.810191897905;8127.75616731499;8231.917680823115;8399.11809260031;8430.789230269169;8674.522901240493;4745.2882067690125;4752.667313288106;4781.9240670848785;4816.54242846929;4832.299316599074;3283.4254005548933;3287.09604858661;3304.0418278698908;3322.7175690066615;3327.9168020799675;599.0714392691398;601.7683191971036;611.6605284067297;614.8032629558588;617.715850708679;686.2108575138631;691.7509696509253;693.448708276921;709.5458906299972;715.742332760206;9206;9298.256139508823;9350.438973661601;9386.530673466299;9396.248300135972;519.0630911205311;612.1216054961145;688.18793823289;708.2492557888552;764.6100488750777;4323.119443042287;4713.222318317439;4717.150912835723;4762.738049407247;4795.424549054136;61681.38318616846;62362.37637623656;62652;62709.68645156745;63848;51865;52081.21878171831;52082.47917520852;52674.736626316626;55235.61910952178;46751.29873051907;47467;48324.27513587229;48336;48963.75518122387;9586;9702.951485242529;9721.659741909;9920.603175872884;9987.850182247126;35114.297714046086;35615;35943;36369;37868.810655946545;47869;48235.5176448231;48338;48615.756921215165;48857;12130;12255.203411778206;12309.44607492647;12340.568080117153;12724.936375318064;13820.792688109888;13982.626954962598;14223.146611203361;14381;14504.637384065483;12519.687007824514;12738.617841464771;13164.670883227996;13221.68268754328;13289.534866279633;12669.493220271086;12804.679883002627;13442.462301508222;13698.863011369758;13734.381952812348;12133.575324863587;13125.671858203621;13409.52495225505;13413.262270575213;13647.454101836212;10275.588976440858;10420.895791041992;10426.478676066317;10634.787304254027;10731.946340268249;10733.14134869193;11025.83461248066;11046.116310695286;11048.226624136234;11214.88785112171 19:00:11 INFO - PROCESS | 7153 | __end_tp_report 19:00:11 INFO - PROCESS | 7153 | __start_cc_report 19:00:11 INFO - PROCESS | 7153 | _x_x_mozilla_cycle_collect,311 19:00:11 INFO - PROCESS | 7153 | __end_cc_report 19:00:11 INFO - PROCESS | 7153 | __startTimestamp1456369211241__endTimestamp 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | ------- Summary: start ------- 19:00:11 INFO - PROCESS | 7153 | Number of tests: 6 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#0] dojo.html Cycles:165 Average:5577.77 Median:5825.13 stddev:624.78 (10.7%) stddev-sans-first:602.56 19:00:11 INFO - PROCESS | 7153 | Values: 3385.3 3421.4 3425.3 3436.8 3447.1 5540.5 5541.8 5562.3 5595.4 5613.2 5553.8 5558.7 5568.5 5577.8 5613.0 4972.5 5011.4 5068.3 5134.5 5163.1 5044.2 5047.2 5095.4 5129.9 5167.2 5177.3 5237.4 5247.6 5261.8 5267.4 5146.9 5152.6 5179.8 5186.2 5213.1 4972.9 4998.9 5036.7 5084.3 5111.0 5261.4 5269.7 5300.0 5309.8 5318.7 5905.7 5956.7 5964.4 5970.5 5981.3 5943.9 5980.0 5983.5 5994.8 6117.9 5691.3 5697.0 5701.3 5704.2 5716.4 6195.0 6200.9 6213.9 6221.7 6241.4 5748.6 5772.1 5936.9 5962.4 6023.1 6080.7 6091.0 6100.0 6107.0 6119.8 5958.0 5980.3 5993.2 6004.7 6005.2 5848.6 5918.3 5945.5 5951.2 6029.6 4494.9 4511.4 4532.7 4548.3 4565.8 4088.1 4099.5 4101.3 4114.2 4122.3 5514.5 5601.6 5686.3 5722.3 5735.4 5982.5 6077.2 6077.7 6081.3 6087.8 5467.8 5688.6 5706.5 5710.7 5720.3 5008.4 5033.4 5037.9 5047.9 5059.3 6095.8 6178.5 6203.5 6260.4 6274.3 5991.2 5998.1 6012.5 6023.3 6051.8 5942.2 6068.9 6125.1 6169.1 6184.9 5844.0 5975.9 6047.0 6050.8 6073.6 6032.5 6037.5 6057.2 6057.5 6062.5 5763.4 5841.8 5863.9 5893.3 5896.1 5799.2 5918.9 5994.1 6010.7 6041.8 5825.4 5844.3 5844.3 5845.7 5852.6 5787.5 5825.1 5966.1 5967.4 5979.9 5651.7 5792.9 5890.7 5894.9 5929.6 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#1] ext.html Cycles:180 Average:55111.96 Median:40575.99 stddev:109563.14 (270.0%) stddev-sans-first:109793.95 19:00:11 INFO - PROCESS | 7153 | Values: 563.2 566.5 580.6 585.6 591.7 37293.8 38387.6 38586.0 38599.4 38604.4 42744.0 42895.1 43171.8 43174.0 43214.6 8660.6 8847.0 8870.8 8871.8 8884.7 8631.5 8751.8 8783.2 8995.9 9002.9 8848.8 9015.5 9017.0 9018.1 9034.1 8915.4 8931.9 8973.0 8981.7 8981.8 8694.4 8848.7 8886.4 8889.6 8891.9 41476.8 41719.4 42126.8 42328.6 42364.4 3579.0 3799.2 3802.6 4252.2 4340.2 32484.0 32530.8 32804.5 32984.0 33206.5 4189.5 4291.7 4306.2 4307.9 4332.2 288621.0 289792.0 290420.0 291131.0 291942.0 44396.3 45209.8 45217.5 45237.3 45328.3 43831.0 43949.6 44064.8 44075.6 44291.8 16539.3 16593.8 16628.2 16718.6 16747.3 13352.2 13388.8 13448.9 13608.2 13802.8 15330.3 15394.8 15517.9 15608.1 15714.8 6021.2 6126.1 6201.6 6262.6 6282.4 1082.7 1136.6 1169.5 1203.2 1219.3 31103.5 32508.3 33186.5 33240.7 33241.7 1130.5 1135.9 1174.5 1180.4 1219.3 16393.8 16507.7 16550.8 16557.8 16615.8 499432.0 503762.0 508840.0 510623.0 777959.0 59932.4 60358.0 60414.4 60415.0 60585.4 1513.0 1540.6 1550.9 1552.5 1558.2 32396.7 32515.5 32823.8 32882.8 33577.8 50108.7 50623.5 50640.5 50699.5 50711.7 312513.0 312998.0 313116.0 314600.0 314893.0 34996.0 35123.5 35543.0 35871.8 36022.8 45609.1 45968.3 46197.5 47041.5 47319.3 43503.0 44432.0 45914.5 46088.3 46657.0 39082.0 39521.7 39538.0 39942.8 40120.2 40093.8 40192.2 40569.2 40582.8 40958.4 36205.1 37339.8 37876.2 38353.8 38538.8 25953.2 27962.7 28038.6 28234.3 28255.9 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#2] jquery.html Cycles:180 Average:29460.01 Median:13570.97 stddev:91092.69 (671.2%) stddev-sans-first:91322.03 19:00:11 INFO - PROCESS | 7153 | Values: 362.8 372.7 376.4 383.8 404.7 15531.7 17023.4 17442.3 18893.9 18919.6 11173.2 17208.4 17373.8 17597.4 17915.6 5172.0 5190.3 5292.3 5310.3 5311.9 4014.3 4143.1 5213.4 5265.4 5594.2 5701.5 5749.8 5751.9 5783.4 5794.3 6500.4 6700.5 6736.5 6804.9 6806.4 6362.3 6496.5 6538.7 6645.0 6664.8 23231.9 23811.3 24532.6 24569.4 24646.5 2366.1 2436.7 2453.7 2495.4 2511.2 14362.2 14771.9 14991.3 15014.5 15239.4 2003.0 2015.0 2096.8 2118.7 2132.9 64857.0 66095.7 67662.0 68040.0 68213.3 15877.8 16096.1 16141.8 16179.8 16452.4 25085.9 25189.4 25313.1 25519.5 25570.2 7869.6 8183.3 8227.8 8258.7 8286.0 7931.0 7931.5 7969.4 8021.7 8065.2 4295.8 4344.9 4397.8 4415.8 4452.6 1850.5 1934.4 1942.8 1960.0 1969.1 983.8 1085.1 1100.9 1110.7 1139.8 17013.9 17595.3 17629.6 17950.3 17973.4 1054.9 1067.5 1067.5 1072.5 1180.3 10188.1 10367.2 10409.5 10435.3 10478.7 544527.0 557125.0 559670.0 562994.0 567039.0 69699.0 70225.6 70263.6 72227.6 72491.6 1188.9 1191.4 1239.2 1244.0 1261.4 16161.3 16161.7 16165.1 16197.1 16316.7 32740.2 32880.7 33824.3 34001.0 34112.7 43126.6 43995.8 44233.3 44319.3 44365.3 7102.0 7162.2 7207.1 7381.7 7393.9 8879.3 10934.5 10958.3 11106.8 11299.0 10416.6 10576.5 10771.1 11008.2 11140.9 10557.3 10614.5 10903.8 10906.8 10985.5 10774.5 11040.4 11114.1 11188.9 11367.3 7197.6 7221.6 7490.1 7585.0 7658.5 10288.6 10331.8 10404.7 10483.5 10530.0 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#3] mootools.html Cycles:180 Average:5886.74 Median:5139.34 stddev:3059.00 (59.5%) stddev-sans-first:3049.44 19:00:11 INFO - PROCESS | 7153 | Values: 1455.7 1486.9 1691.9 1830.1 1848.9 8100.2 8252.6 8310.5 8403.2 8444.4 8388.7 8461.6 8474.4 8480.7 8485.2 2456.4 2465.0 2465.9 2478.1 2480.4 2476.7 2547.2 2547.7 2550.0 2554.9 2427.4 2470.2 2482.2 2496.2 2530.1 2444.5 2456.8 2470.7 2471.0 2471.5 2412.4 2418.7 2423.7 2432.4 2443.6 8030.2 8053.6 8135.0 8142.3 8152.5 4916.8 5147.3 5189.6 5211.3 5227.7 3180.8 3289.0 3324.5 3357.3 3378.9 1064.5 1088.4 1118.0 1134.9 1154.0 11501.2 11688.0 11703.9 11709.8 11735.3 4419.0 4547.2 4549.4 4563.2 4568.4 9523.7 9540.0 9557.5 9567.1 9578.0 5061.7 5065.6 5073.4 5128.7 5131.4 4684.0 4689.4 4697.7 4706.4 4706.5 3698.9 3739.7 3748.7 3756.6 3773.0 1119.3 1125.4 1130.0 1133.0 1155.9 1065.9 1110.9 1178.3 1211.4 1359.1 7471.6 7586.1 7603.3 7617.0 7654.2 1113.6 1180.8 1192.0 1210.5 1224.9 5977.4 5981.4 5981.6 6003.8 6030.3 10081.2 10336.4 10340.8 10345.7 10495.8 10059.8 10092.9 10233.5 10261.0 10306.6 7930.6 8043.3 8061.4 8070.2 8097.7 7502.0 7529.7 7624.5 7635.0 7664.0 8712.5 8837.8 9159.9 9215.1 9228.4 8987.6 9126.9 9204.1 9258.7 9406.7 7498.9 7641.8 7660.6 7663.2 7670.6 7954.3 8061.7 8067.8 8108.1 8112.9 7649.4 7682.9 7756.5 7797.7 7840.7 7360.0 7428.7 7458.6 7529.9 7804.5 7559.7 7576.2 7609.6 7624.6 7674.6 7031.9 7044.2 7071.2 7099.2 7113.6 7038.5 7081.6 7108.8 7109.5 7155.3 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#4] prototype.html Cycles:180 Average:5695.55 Median:6450.85 stddev:1687.59 (26.2%) stddev-sans-first:1644.33 19:00:11 INFO - PROCESS | 7153 | Values: 371.4 379.3 381.5 382.7 387.4 6385.1 6424.8 6435.7 6436.5 6608.2 6393.8 6422.9 6428.7 6441.2 6449.3 4950.5 4951.3 4960.4 4962.5 4967.5 4946.3 4949.7 4959.8 4971.0 4980.3 4780.6 4885.2 4914.2 4915.3 4918.5 4876.5 4886.7 4901.4 4914.1 4914.6 4304.1 4312.4 4313.4 4317.4 4322.6 6023.1 6071.4 6107.8 6113.8 6130.6 5723.0 5764.5 5778.1 5779.4 5783.0 6850.6 6878.4 6884.5 6894.3 6902.5 4758.8 4773.5 4786.2 4787.5 4791.6 6969.4 7076.6 7113.4 7159.0 7166.4 4911.8 4918.3 4920.1 4923.1 4923.3 4973.1 4981.1 4990.8 4992.0 4993.0 5542.4 5707.3 5721.7 5743.8 5744.7 6872.8 6879.0 6898.4 6915.0 6921.9 1714.4 1749.1 1770.0 1770.9 1771.4 1156.4 1175.4 1187.0 1190.5 1192.4 6466.1 6490.4 6505.3 6510.8 6522.2 6963.9 6981.3 7006.6 7025.0 7066.5 6402.6 6427.4 6452.5 6495.3 6514.7 3797.8 3803.5 3820.4 3825.4 3829.2 7081.3 7144.8 7150.8 7168.3 7174.1 6922.4 7139.0 7146.3 7154.3 7196.8 7139.1 7140.3 7143.1 7155.3 7161.9 6946.2 6978.2 6979.1 7001.6 7034.4 6747.9 6801.8 6838.0 6841.8 6843.2 7072.2 7112.2 7125.0 7141.5 7150.0 4886.1 4910.3 4917.5 4925.7 4930.1 6868.0 6988.7 6995.8 7010.6 7013.0 6769.0 6776.3 6787.7 6808.1 6828.0 6759.2 6780.7 6782.9 6788.7 6810.5 6486.2 6663.5 6678.8 6691.1 6696.2 6765.6 6777.8 6806.3 6835.6 6857.2 6668.6 6683.2 6695.3 6697.5 6699.7 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - PROCESS | 7153 | [#5] yui.html Cycles:180 Average:14996.16 Median:4757.70 stddev:16987.41 (357.1%) stddev-sans-first:17002.20 19:00:11 INFO - PROCESS | 7153 | Values: 925.6 932.4 940.2 947.9 949.7 13501.3 13771.6 13812.7 13819.6 14814.8 14208.8 14264.0 14286.1 14296.3 14349.4 784.1 793.6 871.3 876.7 891.8 864.8 874.2 876.0 879.9 880.5 927.9 931.8 937.4 937.8 939.9 923.7 925.8 927.8 928.4 935.1 685.9 687.7 687.9 689.7 690.7 14829.6 14925.6 14965.8 15042.5 15061.8 14027.9 14062.9 14086.2 14261.9 14287.7 10756.7 10803.3 10913.6 11103.9 11867.2 4596.2 4626.6 4670.2 4691.5 4805.8 53250.7 53275.5 54012.7 54106.5 54201.2 11161.4 11225.4 11229.3 11252.4 11543.2 18769.4 18831.0 18832.2 18954.8 18980.8 8127.8 8231.9 8399.1 8430.8 8674.5 4745.3 4752.7 4781.9 4816.5 4832.3 3283.4 3287.1 3304.0 3322.7 3327.9 599.1 601.8 611.7 614.8 617.7 686.2 691.8 693.4 709.5 715.7 9206.0 9298.3 9350.4 9386.5 9396.2 519.1 612.1 688.2 708.2 764.6 4323.1 4713.2 4717.2 4762.7 4795.4 61681.4 62362.4 62652.0 62709.7 63848.0 51865.0 52081.2 52082.5 52674.7 55235.6 46751.3 47467.0 48324.3 48336.0 48963.8 9586.0 9703.0 9721.7 9920.6 9987.9 35114.3 35615.0 35943.0 36369.0 37868.8 47869.0 48235.5 48338.0 48615.8 48857.0 12130.0 12255.2 12309.4 12340.6 12724.9 13820.8 13982.6 14223.1 14381.0 14504.6 12519.7 12738.6 13164.7 13221.7 13289.5 12669.5 12804.7 13442.5 13698.9 13734.4 12133.6 13125.7 13409.5 13413.3 13647.5 10275.6 10420.9 10426.5 10634.8 10731.9 10733.1 11025.8 11046.1 11048.2 11214.9 19:00:11 INFO - PROCESS | 7153 | -------- Summary: end -------- 19:00:11 INFO - PROCESS | 7153 | 19:00:11 INFO - TEST-INFO | 7153: exit 0 19:00:11 INFO - TEST-OK | dromaeo_css | took 1110380ms 19:00:11 INFO - TEST-START | kraken 19:00:11 INFO - operating with platform_type : linux_ 19:00:11 INFO - Initialising browser for kraken test... 19:00:11 INFO - TEST-INFO | started process 7394 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaAirWL/profile http://localhost:57428/getInfo.html) 19:00:15 INFO - PROCESS | 7394 | 19:00:15 INFO - PROCESS | 7394 | (process:7474): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:16 INFO - PROCESS | 7394 | __metrics Screen width/height:1600/1200 19:00:16 INFO - PROCESS | 7394 | colorDepth:24 19:00:16 INFO - PROCESS | 7394 | Browser inner width/height: 1024/697 19:00:16 INFO - PROCESS | 7394 | __metrics 19:00:17 INFO - TEST-INFO | 7394: exit 0 19:00:17 INFO - Browser initialized. 19:00:17 INFO - Running cycle 1/1 for kraken test... 19:00:17 INFO - TEST-INFO | started process 7523 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaAirWL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:18 INFO - PROCESS | 7523 | 19:00:18 INFO - PROCESS | 7523 | (process:7585): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:00:29 INFO - PROCESS | 7523 | RSS: Main: 141008896 19:00:29 INFO - PROCESS | 7523 | 19:00:31 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57428/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:32 INFO - PROCESS | 7523 | RSS: Main: 145682432 19:00:32 INFO - PROCESS | 7523 | 19:00:34 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57428/tests/kraken/driver.html?testName=audio-dft) 19:00:35 INFO - PROCESS | 7523 | RSS: Main: 144375808 19:00:35 INFO - PROCESS | 7523 | 19:00:38 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57428/tests/kraken/driver.html?testName=audio-fft) 19:00:38 INFO - PROCESS | 7523 | RSS: Main: 146677760 19:00:38 INFO - PROCESS | 7523 | 19:00:40 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57428/tests/kraken/driver.html?testName=audio-oscillator) 19:00:41 INFO - PROCESS | 7523 | RSS: Main: 146743296 19:00:41 INFO - PROCESS | 7523 | 19:00:43 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57428/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:00:44 INFO - PROCESS | 7523 | RSS: Main: 145907712 19:00:44 INFO - PROCESS | 7523 | 19:00:47 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57428/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:47 INFO - PROCESS | 7523 | RSS: Main: 144949248 19:00:47 INFO - PROCESS | 7523 | 19:00:51 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57428/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:51 INFO - PROCESS | 7523 | RSS: Main: 144990208 19:00:51 INFO - PROCESS | 7523 | 19:00:54 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57428/tests/kraken/driver.html?testName=json-parse-financial) 19:00:55 INFO - PROCESS | 7523 | RSS: Main: 145121280 19:00:55 INFO - PROCESS | 7523 | 19:00:56 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57428/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:57 INFO - PROCESS | 7523 | RSS: Main: 145928192 19:00:57 INFO - PROCESS | 7523 | 19:00:59 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:59 INFO - PROCESS | 7523 | RSS: Main: 147173376 19:00:59 INFO - PROCESS | 7523 | 19:01:01 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:02 INFO - PROCESS | 7523 | RSS: Main: 147550208 19:01:02 INFO - PROCESS | 7523 | 19:01:04 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:05 INFO - PROCESS | 7523 | RSS: Main: 145747968 19:01:05 INFO - PROCESS | 7523 | 19:01:07 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:08 INFO - PROCESS | 7523 | RSS: Main: 147427328 19:01:08 INFO - PROCESS | 7523 | 19:01:09 INFO - PROCESS | 7523 | Cycle 1(1): loaded http://localhost:57428/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57428/tests/kraken/driver.html?testName=ai-astar) 19:01:10 INFO - PROCESS | 7523 | RSS: Main: 146923520 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | __start_tp_report 19:01:10 INFO - PROCESS | 7523 | _x_x_mozilla_page_load 19:01:10 INFO - PROCESS | 7523 | _x_x_mozilla_page_load_details 19:01:10 INFO - PROCESS | 7523 | |i|pagename|runs| 19:01:10 INFO - PROCESS | 7523 | |0;ai-astar;114;109;113;112;114;122;112;111;111;111 19:01:10 INFO - PROCESS | 7523 | |1;audio-beat-detection;152;123;153;163;127;150;147;127;164;136 19:01:10 INFO - PROCESS | 7523 | |2;audio-dft;164;162;163;162;160;161;163;165;164;162 19:01:10 INFO - PROCESS | 7523 | |3;audio-fft;77;74;74;155;73;76;75;73;164;77 19:01:10 INFO - PROCESS | 7523 | |4;audio-oscillator;96;96;141;96;97;96;137;95;97;131 19:01:10 INFO - PROCESS | 7523 | |5;imaging-gaussian-blur;110;110;109;110;110;109;110;110;109;110 19:01:10 INFO - PROCESS | 7523 | |6;imaging-darkroom;149;146;146;147;147;146;147;146;147;147 19:01:10 INFO - PROCESS | 7523 | |7;imaging-desaturate;97;98;96;97;96;97;98;96;97;96 19:01:10 INFO - PROCESS | 7523 | |8;json-parse-financial;55;57;55;56;55;59;55;62;53;53 19:01:10 INFO - PROCESS | 7523 | |9;json-stringify-tinderbox;65;64;65;64;64;66;65;65;64;66 19:01:10 INFO - PROCESS | 7523 | |10;stanford-crypto-aes;79;83;82;88;80;82;82;80;81;81 19:01:10 INFO - PROCESS | 7523 | |11;stanford-crypto-ccm;126;116;112;111;114;116;111;112;122;114 19:01:10 INFO - PROCESS | 7523 | |12;stanford-crypto-pbkdf2;131;148;146;134;141;129;141;136;139;146 19:01:10 INFO - PROCESS | 7523 | |13;stanford-crypto-sha256-iterative;67;66;70;64;75;74;64;65;64;64 19:01:10 INFO - PROCESS | 7523 | __end_tp_report 19:01:10 INFO - PROCESS | 7523 | __start_cc_report 19:01:10 INFO - PROCESS | 7523 | _x_x_mozilla_cycle_collect,737 19:01:10 INFO - PROCESS | 7523 | __end_cc_report 19:01:10 INFO - PROCESS | 7523 | __startTimestamp1456369270187__endTimestamp 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | ------- Summary: start ------- 19:01:10 INFO - PROCESS | 7523 | Number of tests: 14 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.50 stddev:3.54 (3.1%) stddev-sans-first:3.73 19:01:10 INFO - PROCESS | 7523 | Values: 114.0 109.0 113.0 112.0 114.0 122.0 112.0 111.0 111.0 111.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:151.00 stddev:15.03 (10.0%) stddev-sans-first:15.68 19:01:10 INFO - PROCESS | 7523 | Values: 152.0 123.0 153.0 163.0 127.0 150.0 147.0 127.0 164.0 136.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.51 19:01:10 INFO - PROCESS | 7523 | Values: 164.0 162.0 163.0 162.0 160.0 161.0 163.0 165.0 164.0 162.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.50 stddev:35.77 (48.0%) stddev-sans-first:37.54 19:01:10 INFO - PROCESS | 7523 | Values: 77.0 74.0 74.0 155.0 73.0 76.0 75.0 73.0 164.0 77.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:96.00 stddev:19.57 (20.4%) stddev-sans-first:20.25 19:01:10 INFO - PROCESS | 7523 | Values: 96.0 96.0 141.0 96.0 97.0 96.0 137.0 95.0 97.0 131.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:01:10 INFO - PROCESS | 7523 | Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.53 19:01:10 INFO - PROCESS | 7523 | Values: 149.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 147.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 19:01:10 INFO - PROCESS | 7523 | Values: 97.0 98.0 96.0 97.0 96.0 97.0 98.0 96.0 97.0 96.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:2.75 (5.0%) stddev-sans-first:2.89 19:01:10 INFO - PROCESS | 7523 | Values: 55.0 57.0 55.0 56.0 55.0 59.0 55.0 62.0 53.0 53.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 19:01:10 INFO - PROCESS | 7523 | Values: 65.0 64.0 65.0 64.0 64.0 66.0 65.0 65.0 64.0 66.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:2.49 (3.0%) stddev-sans-first:2.42 19:01:10 INFO - PROCESS | 7523 | Values: 79.0 83.0 82.0 88.0 80.0 82.0 82.0 80.0 81.0 81.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:115.00 stddev:4.97 (4.3%) stddev-sans-first:3.49 19:01:10 INFO - PROCESS | 7523 | Values: 126.0 116.0 112.0 111.0 114.0 116.0 111.0 112.0 122.0 114.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.10 Median:141.00 stddev:6.54 (4.6%) stddev-sans-first:6.24 19:01:10 INFO - PROCESS | 7523 | Values: 131.0 148.0 146.0 134.0 141.0 129.0 141.0 136.0 139.0 146.0 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - PROCESS | 7523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:4.24 (6.4%) stddev-sans-first:4.50 19:01:10 INFO - PROCESS | 7523 | Values: 67.0 66.0 70.0 64.0 75.0 74.0 64.0 65.0 64.0 64.0 19:01:10 INFO - PROCESS | 7523 | -------- Summary: end -------- 19:01:10 INFO - PROCESS | 7523 | 19:01:10 INFO - TEST-INFO | 7523: exit 0 19:01:11 INFO - TEST-OK | kraken | took 59142ms 19:01:11 INFO - TEST-START | v8_7 19:01:11 INFO - operating with platform_type : linux_ 19:01:11 INFO - Initialising browser for v8_7 test... 19:01:11 INFO - TEST-INFO | started process 7814 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHV9Iex/profile http://localhost:57428/getInfo.html) 19:01:14 INFO - PROCESS | 7814 | 19:01:14 INFO - PROCESS | 7814 | (process:7895): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:15 INFO - PROCESS | 7814 | __metrics Screen width/height:1600/1200 19:01:15 INFO - PROCESS | 7814 | colorDepth:24 19:01:15 INFO - PROCESS | 7814 | Browser inner width/height: 1024/697 19:01:15 INFO - PROCESS | 7814 | __metrics 19:01:16 INFO - TEST-INFO | 7814: exit 0 19:01:16 INFO - Browser initialized. 19:01:16 INFO - Running cycle 1/1 for v8_7 test... 19:01:16 INFO - TEST-INFO | started process 7944 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHV9Iex/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:17 INFO - PROCESS | 7944 | 19:01:17 INFO - PROCESS | 7944 | (process:8007): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:01:28 INFO - PROCESS | 7944 | RSS: Main: 140931072 19:01:28 INFO - PROCESS | 7944 | 19:01:50 INFO - PROCESS | 7944 | Cycle 1(1): loaded http://localhost:57428/tests/v8_7/run.html (next: http://localhost:57428/tests/v8_7/run.html) 19:01:51 INFO - PROCESS | 7944 | RSS: Main: 144990208 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | __start_tp_report 19:01:51 INFO - PROCESS | 7944 | _x_x_mozilla_page_load 19:01:51 INFO - PROCESS | 7944 | _x_x_mozilla_page_load_details 19:01:51 INFO - PROCESS | 7944 | |i|pagename|runs| 19:01:51 INFO - PROCESS | 7944 | |0;Richards;166.47244880972198 19:01:51 INFO - PROCESS | 7944 | |1;DeltaBlue;170.32873445750297 19:01:51 INFO - PROCESS | 7944 | |2;Encrypt;280.97780275358247 19:01:51 INFO - PROCESS | 7944 | |3;Decrypt;5208.333333333333 19:01:51 INFO - PROCESS | 7944 | |4;RayTrace;921.6589861751152 19:01:51 INFO - PROCESS | 7944 | |5;Earley;568.8282138794084 19:01:51 INFO - PROCESS | 7944 | |6;Boyer;11131.868131868132 19:01:51 INFO - PROCESS | 7944 | |7;RegExp;39019.230769230766 19:01:51 INFO - PROCESS | 7944 | |8;Splay;530.7855626326964 19:01:51 INFO - PROCESS | 7944 | |9;NavierStokes;4822.115384615385 19:01:51 INFO - PROCESS | 7944 | __end_tp_report 19:01:51 INFO - PROCESS | 7944 | __startTimestamp1456369311067__endTimestamp 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | ------- Summary: start ------- 19:01:51 INFO - PROCESS | 7944 | Number of tests: 10 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 166.5 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#1] DeltaBlue Cycles:1 Average:170.33 Median:170.33 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 170.3 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 281.0 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 5208.3 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#4] RayTrace Cycles:1 Average:921.66 Median:921.66 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 921.7 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#5] Earley Cycles:1 Average:568.83 Median:568.83 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 568.8 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 11131.9 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#7] RegExp Cycles:1 Average:39019.23 Median:39019.23 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 39019.2 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#8] Splay Cycles:1 Average:530.79 Median:530.79 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 530.8 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - PROCESS | 7944 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 19:01:51 INFO - PROCESS | 7944 | Values: 4822.1 19:01:51 INFO - PROCESS | 7944 | -------- Summary: end -------- 19:01:51 INFO - PROCESS | 7944 | 19:01:51 INFO - TEST-INFO | 7944: exit 0 19:01:51 INFO - TEST-OK | v8_7 | took 40858ms 19:01:51 INFO - SUITE-END | took 1210s 19:01:52 INFO - Completed test suite (00:20:10) 19:01:52 INFO - Working with test: dromaeo_css 19:01:52 INFO - Generating results file: dromaeo_css 19:01:52 INFO - Working with test: kraken 19:01:52 INFO - Generating results file: kraken 19:01:52 INFO - javascript benchmark 19:01:52 INFO - Working with test: v8_7 19:01:52 INFO - Generating results file: v8_7 19:01:52 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 19:01:52 INFO - process_Request line: dromaeo_css 7457.09 graph.html#tests=[[72,52,43]] 19:01:52 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:52 INFO - process_Request line: kraken 1497.40 graph.html#tests=[[232,52,43]] 19:01:52 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:01:52 INFO - process_Request line: v8_7 21961.41 graph.html#tests=[[230,52,43]] 19:01:52 INFO - RETURN: dromaeo_css: 7457.09 19:01:52 INFO - RETURN: kraken: 1497.40 19:01:52 INFO - RETURN: v8_7: 21961.41 19:01:52 INFO - javascript benchmark 19:01:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3385.322935412917, 3421.3670470962875, 3425.297813948141, 3436.82815859207, 3447.0520606833124, 5540.501354878055, 5541.833744987647, 5562.3047119110115, 5595.356533998586, 5613.2141500189955, 5553.7778488860495, 5558.749856256478, 5568.470995255454, 5577.832665020046, 5613.045782217023, 4972.544081863107, 5011.423686276079, 5068.290439338495, 5134.460881607433, 5163.122269214243, 5044.218146187329, 5047.167217409123, 5095.439501654815, 5129.948700512984, 5167.199084141964, 5177.275181474578, 5237.371515418136, 5247.553957913563, 5261.76322065508, 5267.446918073604, 5146.9485305146845, 5152.562032227265, 5179.7928082877015, 5186.24799404088, 5213.113770658978, 4972.8508144755715, 4998.875028124289, 5036.672616279967, 5084.339035925306, 5110.9744451277875, 5261.394939581921, 5269.710165940872, 5300.019496393141, 5309.761060752276, 5318.680879147263, 5905.704714764244, 5956.702164891738, 5964.403559644044, 5970.492508136814, 5981.282246130449, 5943.881122377571, 5979.970100149515, 5983.521318294526, 5994.7901823436405, 6117.888303246575, 5691.3170419549915, 5696.971515142398, 5701.25883635129, 5704.2299289595785, 5716.428357164292, 6195.0, 6200.875982480326, 6213.937860621426, 6221.657808820558, 6241.375862413813, 5748.597598168171, 5772.076467765138, 5936.881262374728, 5962.433568810956, 6023.066424704178, 6080.69596520181, 6090.969545152246, 6099.969500152471, 6106.992346262906, 6119.755209791559, 5958.0, 5980.282366116007, 5993.190919225849, 6004.729787159588, 6005.219321488266, 5848.590598658053, 5918.289805223315, 5945.464908158287, 5951.196588460502, 6029.638221706711, 4494.921218907504, 4511.390962220124, 4532.7280363178315, 4548.31775233711, 4565.7717114144825, 4088.1210539733506, 4099.549049604541, 4101.282275601758, 4114.19773144234, 4122.299209134454, 5514.531264842453, 5601.6358936668985, 5686.289213848269, 5722.313322401338, 5735.3977832327, 5982.521398288213, 6077.179580756541, 6077.726502307407, 6081.27024757032, 6087.786927457518, 5467.781288748485, 5688.63023903445, 5706.543476521868, 5710.65736055838, 5720.2849643794525, 5008.4240312364545, 5033.370828646419, 5037.924431133536, 5047.87380315495, 5059.266406371129, 6095.847603809941, 6178.505719542426, 6203.503719702413, 6260.436560709558, 6274.341194174637, 5991.191189189403, 5998.070299103646, 6012.549058820693, 6023.3073196582955, 6051.848703782441, 5942.168096466412, 6068.9089663654195, 6125.081237814185, 6169.136320915165, 6184.938150618436, 5844.035734103825, 5975.850603734942, 6047.002244629763, 6050.848728781815, 6073.605215660968, 6032.4570788629235, 6037.486813620716, 6057.1519987200945, 6057.485113765203, 6062.454379105725, 5763.36602973681, 5841.795537156179, 5863.941360586339, 5893.263342082239, 5896.086106653475, 5799.188113664006, 5918.940810591839, 5994.10088486713, 6010.699465026643, 6041.78853740117, 5825.3883342248455, 5844.2986841577585, 5844.327902291121, 5845.678487683218, 5852.561057920758, 5787.479126878601, 5825.126231065374, 5966.105084237399, 5967.403259674172, 5979.940200598112, 5651.745671444713, 5792.94207057924, 5890.734916928663, 5894.941050589439, 5929.6145750526075], "unit": "score", "name": "dojo.html", "value": 5537.3054515892145}, {"lowerIsBetter": false, "replicates": [563.2002556369954, 566.5071387892534, 580.6342004537141, 585.6193474241742, 591.6923199936033, 37293.81353093234, 38387.61612383875, 38586.0, 38599.421008684825, 38604.420933686015, 42744.0, 42895.14209715812, 43171.784141079326, 43174.0, 43214.567854321525, 8660.566971651424, 8847.0, 8870.822583548357, 8871.822563548725, 8884.73345799627, 8631.525266110362, 8751.824963500727, 8783.209511143996, 8995.865062024075, 9002.909970900306, 8848.823023539526, 9015.504147271897, 9017.0, 9018.05310442404, 9034.05142460042, 8915.42049766763, 8931.866022009675, 8972.955135224347, 8981.685641002567, 8981.775455613564, 8694.39139260252, 8848.690295839679, 8886.422382545114, 8889.644414223423, 8891.86662200061, 41476.792616037026, 41719.374209386886, 42126.78936605328, 42328.576714232775, 42364.364534532004, 3578.982105089484, 3799.204840793554, 3802.6007269236884, 4252.213340532012, 4340.175366680321, 32484.0, 32530.83734581312, 32804.507932381035, 32984.0, 33206.501902471486, 4189.539150693421, 4291.678124140671, 4306.160298741715, 4307.91384172318, 4332.1985432695055, 288621.0, 289791.9999999979, 290420.0, 291131.0, 291942.0, 44396.3340549892, 45209.77395113003, 45217.54782452133, 45237.32144017842, 45328.3200751989, 43831.0, 43949.56050439519, 44064.77967610142, 44075.559244407144, 44291.778541107735, 16539.25573349202, 16593.83406165947, 16628.168591570615, 16718.58203544921, 16747.33010679559, 13352.198868067948, 13388.799168012487, 13448.93275533616, 13608.183508989492, 13802.792958105636, 15330.310136043905, 15394.846051539342, 15517.922410388102, 15608.141552214738, 15714.842851571566, 6021.217241758631, 6126.142340072393, 6201.627902325875, 6262.5929314594405, 6282.434580887742, 1082.7076689293847, 1136.6078702847503, 1169.5204965964085, 1203.1638011581867, 1219.318136611357, 31103.533446998314, 32508.349833003682, 33186.50220246698, 33240.667593324244, 33241.66758332434, 1130.5025788653131, 1135.8807325230732, 1174.4949671641277, 1180.4392913366255, 1219.268438936631, 16393.83606163947, 16507.66984660324, 16550.83449165493, 16557.751633725504, 16615.750763738553, 499432.0, 503762.0, 508840.0, 510623.0, 777959.0, 59932.400675992685, 60358.0, 60414.39585604176, 60415.0, 60585.394146058854, 1512.954611361661, 1540.6225474758533, 1550.9069455832687, 1552.534239728077, 1558.2364641325669, 32396.67603324031, 32515.51226731648, 32823.83588082044, 32882.835585821915, 33577.83211083929, 50108.74945625249, 50623.49376506188, 50640.49359506358, 50699.493005069475, 50711.746441267554, 312513.0, 312998.0, 313116.0, 314600.0, 314893.0, 34996.0, 35123.47314790229, 35543.0, 35871.82064089663, 36022.819885900404, 45609.087818244116, 45968.31047534223, 46197.53802462067, 47041.52958470371, 47319.29021064618, 43503.0, 44432.0, 45914.540854591025, 46088.308675370565, 46657.0, 39082.0, 39521.73307050472, 39538.0, 39942.80028599838, 40120.1975960485, 40093.79953100216, 40192.1961560773, 40569.1886162281, 40582.79708601438, 40958.38562421626, 36205.0948726284, 37339.813300933325, 37876.242475150895, 38353.80823095867, 38538.80730596329, 25953.22140335793, 27962.72037279601, 28038.579421309103, 28234.2941426466, 28255.858720706266], "unit": "score", "name": "ext.html", "value": 19678.083340425448}, {"lowerIsBetter": false, "replicates": [362.7678285897026, 372.6888048479519, 376.3996425701006, 383.8291960077765, 404.749324587026, 15531.68936621267, 17023.40418085367, 17442.30230790767, 18893.905530472344, 18919.621607567857, 11173.21787474877, 17208.39770608029, 17373.82626173738, 17597.3840915568, 17915.552111197194, 5171.974140129303, 5190.325257716491, 5292.259083728281, 5310.283111779918, 5311.9468805312035, 4014.2774300625874, 4143.067809742814, 5213.400458947212, 5265.420803711589, 5594.160875868612, 5701.486866182064, 5749.827505174831, 5751.884962300752, 5783.36382997872, 5794.333651630053, 6500.382463665944, 6700.497462690269, 6736.528443008967, 6804.897926531056, 6806.421454176401, 6362.331955144736, 6496.480281577463, 6538.705758240843, 6645.0, 6664.800055998279, 23231.883840580856, 23811.285661430185, 24532.632010519857, 24569.38576535583, 24646.507069858682, 2366.148186652804, 2436.707595088583, 2453.7423570525193, 2495.438526331579, 2511.234073607549, 14362.210078445682, 14771.852281477155, 14991.32539035746, 15014.474493392789, 15239.390424383011, 2002.9799702003086, 2014.9697754533693, 2096.790320967906, 2118.692789545523, 2132.8826914519695, 64857.0, 66095.66952165257, 67662.0, 68040.0, 68213.31786682119, 15877.761833572506, 16096.11471369086, 16141.757873631905, 16179.83820161807, 16452.4241651544, 25085.87457062703, 25189.370265743502, 25313.114041008477, 25519.489610207693, 25570.23289301324, 7869.606519673994, 8183.345332373396, 8227.794305142299, 8258.669653213925, 8286.047104582929, 7931.0, 7931.524108553505, 7969.362451004022, 8021.679132834738, 8065.233802788725, 4295.8281668733525, 4344.9348259776125, 4397.758123303185, 4415.757133357696, 4452.577005184502, 1850.4911149434013, 1934.3713293179774, 1942.77658069321, 1959.9902000489906, 1969.084375765276, 983.8032393521324, 1085.1427372375892, 1100.944952752359, 1110.6667999600088, 1139.8062329404022, 17013.914930425268, 17595.29618815233, 17629.55926101832, 17950.281988720566, 17973.37093201732, 1054.862867827193, 1067.4876059491487, 1067.514281002142, 1072.4905669806778, 1180.3154170581042, 10188.134008609351, 10367.170626350025, 10409.53157107932, 10435.269531132748, 10478.685639430829, 544527.0, 557125.0, 559670.0, 562994.0, 567039.0, 69699.0, 70225.64887175531, 70263.64868175627, 72227.63886180536, 72491.63754181196, 1188.857337119534, 1191.3745283726114, 1239.1821397877359, 1243.9689007774878, 1261.4008346035744, 16161.27274272637, 16161.67676646484, 16165.110918899574, 16197.109158996369, 16316.67366652684, 32740.181495462803, 32880.67119328776, 33824.323513530086, 34001.0, 34112.65887341095, 43126.56873431351, 43995.78002110097, 44233.33649995188, 44319.33520997123, 44365.33451998158, 7102.0, 7162.176349719849, 7207.063081799332, 7381.7416390428225, 7393.889091663522, 8879.268542634125, 10934.507947142238, 10958.342499450058, 11106.777864442503, 11299.0, 10416.635417760343, 10576.524056417325, 10771.13830893511, 11008.229423940247, 11140.888591113986, 10557.313774604627, 10614.522346494581, 10903.836442453528, 10906.836397453886, 10985.450727463754, 10774.515146818256, 11040.392778396945, 11114.110871130451, 11188.888111118784, 11367.31796092204, 7197.640117993975, 7221.638918053971, 7490.101187857274, 7585.0, 7658.502197357154, 10288.639897603547, 10331.793364132525, 10404.68785936423, 10483.475826208507, 10530.0], "unit": "score", "name": "jquery.html", "value": 9127.522380681947}, {"lowerIsBetter": false, "replicates": [1455.7234125516152, 1486.8513148685133, 1691.864650827934, 1830.1306879232359, 1848.8520918326535, 8100.230478104585, 8252.628631711572, 8310.542920139398, 8403.243708066273, 8444.408891377607, 8388.66445342187, 8461.576921153934, 8474.364422668294, 8480.703175388862, 8485.236328730412, 2456.3613460500264, 2464.963025554609, 2465.938351541208, 2478.10788116278, 2480.3923038855505, 2476.6904136982876, 2547.1721690450586, 2547.7070136934212, 2549.974500254992, 2554.8722563871825, 2427.3567504611206, 2470.1601455505124, 2482.168473561359, 2496.1762618335997, 2530.0891678995545, 2444.49887773007, 2456.7788898999174, 2470.72821989581, 2470.950580988388, 2471.542764588548, 2412.4089598048413, 2418.6734790803193, 2423.7212720537186, 2432.3797431654816, 2443.5601591713485, 8030.156833532454, 8053.557054362008, 8135.0, 8142.267195952392, 8152.470089444227, 4916.778744956449, 5147.279380886679, 5189.610779191576, 5211.296474975906, 5227.660202086852, 3180.761442891769, 3288.9506657400157, 3324.484704870749, 3357.261402491448, 3378.881739139143, 1064.4571268652965, 1088.357868857378, 1117.9888201117967, 1134.8921852424007, 1153.9596114135966, 11501.194916355858, 11688.0, 11703.941480292544, 11709.824352634718, 11735.295882247092, 4419.049904270597, 4547.226971414867, 4549.385832912514, 4563.224251877189, 4568.428946381702, 9523.714288571355, 9539.952300238594, 9557.474338911426, 9567.138957493858, 9578.0, 5061.721605311744, 5065.645404821627, 5073.441921388644, 5128.7179205144075, 5131.409887862869, 4684.016356565091, 4689.390379250675, 4697.694649847749, 4706.411698537683, 4706.458757242961, 3698.9445158322646, 3739.6821270191795, 3748.700103991674, 3756.5912782706487, 3773.0, 1119.261287550213, 1125.352922069813, 1129.9774004519863, 1132.9546818127183, 1155.8555180602425, 1065.8614380130534, 1110.8666959964694, 1178.2753606532092, 1211.4064108586729, 1359.0609038501811, 7471.551706897603, 7586.127595326498, 7603.2776886195725, 7617.047869016373, 7654.196309387546, 1113.6269349767917, 1180.7874582575218, 1191.988080119205, 1210.4673943464848, 1224.908131890112, 5977.432143946318, 5981.37195594465, 5981.551383646244, 6003.8198854034445, 6030.33666296707, 10081.243906707026, 10336.431496267778, 10340.844887326695, 10345.741356465998, 10495.842562361571, 10059.798804023878, 10092.949535252277, 10233.539490722935, 10261.0, 10306.639267625747, 7930.603469826601, 8043.276105150681, 8061.435699500978, 8070.2333278338465, 8097.676092956333, 7501.962490187514, 7529.736459223901, 7624.504407213513, 7635.0, 7663.961680191564, 8712.520811355183, 8837.823243535222, 9159.862602061108, 9215.124563166488, 9228.35401521887, 8987.550622468982, 9126.863097053681, 9204.125608067223, 9258.675946341846, 9406.717798466058, 7498.925010749823, 7641.847163056596, 7660.578668173304, 7663.195364486649, 7670.616469176631, 7954.284114429498, 8061.717839875576, 8067.838643226985, 8108.067572229269, 8112.918870811216, 7649.388048955959, 7682.884756728766, 7756.457048006585, 7797.688092476237, 7840.72557460509, 7360.0, 7428.702851885864, 7458.627068646438, 7529.887051694339, 7804.531728096333, 7559.697612095454, 7576.166621671501, 7609.581473018816, 7624.58064806441, 7674.6162691864065, 7031.929680703128, 7044.189918159477, 7071.222165561887, 7099.183593886769, 7113.57318560888, 7038.542494737826, 7081.575105493687, 7108.786736397917, 7109.537880037781, 7155.284471552803], "unit": "score", "name": "mootools.html", "value": 4822.501122063148}, {"lowerIsBetter": false, "replicates": [371.40389674572316, 379.2888334373051, 381.45261549676206, 382.71870175421077, 387.4266086192435, 6385.0741642461935, 6424.839379015527, 6435.742570297189, 6436.452901503372, 6608.207015158176, 6393.808185754423, 6422.9357706422925, 6428.710708018139, 6441.227052753676, 6449.258335291443, 4950.504949505057, 4951.2573114033, 4960.429550601691, 4962.478939711333, 4967.50324967504, 4946.332245146895, 4949.7030178189425, 4959.776810043539, 4971.005798840229, 4980.252962055684, 4780.617550595944, 4885.2427873679635, 4914.213725803872, 4915.262710593403, 4918.483559226283, 4876.487968763265, 4886.706797592155, 4901.362822833027, 4914.066327397783, 4914.606831453493, 4304.096139810644, 4312.3531470279395, 4313.396124542566, 4317.417148684919, 4322.589354011364, 6023.066424704178, 6071.423214794588, 6107.816765497042, 6113.847153821145, 6130.63216207029, 5722.971385143048, 5764.452377024176, 5778.133280007991, 5779.381773103496, 5783.0, 6850.588964662086, 6878.38094571486, 6884.48366372519, 6894.276101009372, 6902.516823822334, 4758.809647614091, 4773.4510531289, 4786.1863483207935, 4787.473377928425, 4791.6406269529925, 6969.372756451944, 7076.610786406745, 7113.430925525997, 7158.99774031636, 7166.355028047448, 4911.803527858846, 4918.286848406961, 4920.114379411669, 4923.138450771101, 4923.261510773413, 4973.055119527278, 4981.128302547112, 4990.80036798524, 4992.026554821775, 4993.0, 5542.418046105182, 5707.315122185364, 5721.685307308138, 5743.770249190069, 5744.655320680772, 6872.793816185523, 6879.0, 6898.448124150056, 6915.0, 6921.861562768717, 1714.374253397501, 1749.0817320906372, 1770.0353307447472, 1770.9026003569927, 1771.4419957713278, 1156.3582211872324, 1175.353555544447, 1187.0088476122362, 1190.4940400329824, 1192.356127691037, 6466.094746735461, 6490.448311893448, 6505.349465053551, 6510.7721229756735, 6522.184726909137, 6963.895541566881, 6981.2669669684965, 7006.649667516705, 7024.964875175591, 7066.470014748915, 6402.551821372459, 6427.389398007182, 6452.451541619015, 6495.3179916109075, 6514.739410423625, 3797.7721336719887, 3803.5435747710453, 3820.3696390095324, 3825.387937929918, 3829.215010922754, 7081.327273908971, 7144.821379465555, 7150.785476435715, 7168.2831716827895, 7174.139103307532, 6922.446204303644, 7138.964305178441, 7146.32109949554, 7154.284571542804, 7196.784096477114, 7139.071920650283, 7140.285971402818, 7143.142822861186, 7155.3202445767565, 7161.92838071623, 6946.16646002483, 6978.232394436709, 6979.057827193467, 7001.579905205704, 7034.366906978396, 6747.865042699021, 6801.829954251183, 6837.965810170917, 6841.760538381132, 6843.213030501556, 7072.186698529735, 7112.217656057726, 7124.964375178299, 7141.535800172972, 7149.964250178716, 4886.071646387175, 4910.337104490848, 4917.508249175054, 4925.655204135819, 4930.112579735539, 6867.965660171867, 6988.685509152202, 6995.825104372431, 7010.614416206953, 7012.964935175291, 6768.96615516939, 6776.322367763184, 6787.66061696923, 6808.080909077211, 6828.0, 6759.222689390783, 6780.660966951534, 6782.93217067823, 6788.7284508619105, 6810.455163586802, 6486.156799616208, 6663.466922646274, 6678.766243181465, 6691.063251144747, 6696.229933557704, 6765.560238584476, 6777.762778302736, 6806.285340039422, 6835.555688880207, 6857.177138743184, 6668.599884006975, 6683.231428385603, 6695.296993815774, 6697.497687673346, 6699.732010719516], "unit": "score", "name": "prototype.html", "value": 5154.110380758821}, {"lowerIsBetter": false, "replicates": [925.5557332480411, 932.426557667035, 940.2055263302511, 947.8815148106487, 949.6960972488806, 13501.32493375331, 13771.586852394432, 13812.723745525083, 13819.585412437618, 14814.777778333333, 14208.786868196985, 14264.0, 14286.071405358645, 14296.285185740697, 14349.426022959069, 784.051297929506, 793.5754371411296, 871.3377832847034, 876.6843936182969, 891.7993451473432, 864.8486514859875, 874.204473928725, 875.9562021898911, 879.9252063574604, 880.4981160738382, 927.9072092790734, 931.818295432391, 937.3813283233068, 937.7936853892132, 939.9389039712397, 923.676713150392, 925.8287216864901, 927.7587827164951, 928.3501548915785, 935.1163150822475, 685.9451243900476, 687.6630451078935, 687.8727435424463, 689.7206631314326, 690.6857379892137, 14829.629259268604, 14925.626859328495, 14965.775513367309, 15042.548723538312, 15061.774073388908, 14027.929860350734, 14062.859371406359, 14086.15483071019, 14261.928690356586, 14287.714245715131, 10756.73108172294, 10803.297785643987, 10913.618023369223, 11103.888961110366, 11867.228630139014, 4596.218642830727, 4626.58360747531, 4670.182718024332, 4691.507391723854, 4805.783739731685, 53250.73374633141, 53275.46724532744, 54012.729936350064, 54106.458935410534, 54201.1869821953, 11161.386123763108, 11225.438728063564, 11229.3262404256, 11252.381119038368, 11543.19197656156, 18769.436916892515, 18831.0, 18832.24671013144, 18954.81045189558, 18980.810191897905, 8127.75616731499, 8231.917680823115, 8399.11809260031, 8430.789230269169, 8674.522901240493, 4745.2882067690125, 4752.667313288106, 4781.9240670848785, 4816.54242846929, 4832.299316599074, 3283.4254005548933, 3287.09604858661, 3304.0418278698908, 3322.7175690066615, 3327.9168020799675, 599.0714392691398, 601.7683191971036, 611.6605284067297, 614.8032629558588, 617.715850708679, 686.2108575138631, 691.7509696509253, 693.448708276921, 709.5458906299972, 715.742332760206, 9206.0, 9298.256139508823, 9350.438973661601, 9386.530673466299, 9396.248300135972, 519.0630911205311, 612.1216054961145, 688.18793823289, 708.2492557888552, 764.6100488750777, 4323.119443042287, 4713.222318317439, 4717.150912835723, 4762.738049407247, 4795.424549054136, 61681.38318616846, 62362.37637623656, 62652.0, 62709.68645156745, 63848.0, 51865.0, 52081.21878171831, 52082.47917520852, 52674.736626316626, 55235.61910952178, 46751.29873051907, 47467.0, 48324.27513587229, 48336.0, 48963.75518122387, 9586.0, 9702.951485242529, 9721.659741909, 9920.603175872884, 9987.850182247126, 35114.297714046086, 35615.0, 35943.0, 36369.0, 37868.810655946545, 47869.0, 48235.5176448231, 48338.0, 48615.756921215165, 48857.0, 12130.0, 12255.203411778206, 12309.44607492647, 12340.568080117153, 12724.936375318064, 13820.792688109888, 13982.626954962598, 14223.146611203361, 14381.0, 14504.637384065483, 12519.687007824514, 12738.617841464771, 13164.670883227996, 13221.68268754328, 13289.534866279633, 12669.493220271086, 12804.679883002627, 13442.462301508222, 13698.863011369758, 13734.381952812348, 12133.575324863587, 13125.671858203621, 13409.52495225505, 13413.262270575213, 13647.454101836212, 10275.588976440858, 10420.895791041992, 10426.478676066317, 10634.787304254027, 10731.946340268249, 10733.14134869193, 11025.83461248066, 11046.116310695286, 11048.226624136234, 11214.88785112171], "unit": "score", "name": "yui.html", "value": 6955.3713553857915}], "name": "dromaeo_css", "value": 7457.088985842475}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 113.0, 112.0, 114.0, 122.0, 112.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 153.0, 163.0, 127.0, 150.0, 147.0, 127.0, 164.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 162.0, 160.0, 161.0, 163.0, 165.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [77.0, 74.0, 74.0, 155.0, 73.0, 76.0, 75.0, 73.0, 164.0, 77.0], "unit": "score", "name": "audio-fft", "value": 91.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 96.0, 97.0, 96.0, 137.0, 95.0, 97.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [149.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 97.0, 96.0, 97.0, 98.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.8}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 55.0, 56.0, 55.0, 59.0, 55.0, 62.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 66.0, 65.0, 65.0, 64.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [79.0, 83.0, 82.0, 88.0, 80.0, 82.0, 82.0, 80.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.8}, {"lowerIsBetter": true, "replicates": [126.0, 116.0, 112.0, 111.0, 114.0, 116.0, 111.0, 112.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [131.0, 148.0, 146.0, 134.0, 141.0, 129.0, 141.0, 136.0, 139.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 70.0, 64.0, 75.0, 74.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1497.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [170.32873445750297], "unit": "score", "name": "DeltaBlue", "value": 388.1787779999999}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [921.6589861751152], "unit": "score", "name": "RayTrace", "value": 802.8880650000001}, {"lowerIsBetter": false, "replicates": [568.8282138794084], "unit": "score", "name": "Earley", "value": 1171.6419540000004}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [39019.230769230766], "unit": "score", "name": "RegExp", "value": 23.347077378018717}, {"lowerIsBetter": false, "replicates": [530.7855626326964], "unit": "score", "name": "Splay", "value": 153.529044}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21961.405313648753}]} 19:01:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21961.41"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1497.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7457.09"}}} 19:01:52 INFO - Return code: 0 19:01:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:01:52 INFO - # TBPL SUCCESS # 19:01:52 INFO - Running post-action listener: _resource_record_post_action 19:01:52 INFO - Running post-run listener: _resource_record_post_run 19:01:53 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 827392; Write bytes: 264089600; Read time: 244; Write time: 194436 19:01:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 5238784; Read time: 0; Write time: 1064 19:01:53 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 827392; Write bytes: 258850816; Read time: 244; Write time: 193372 19:01:53 INFO - Running post-run listener: _upload_blobber_files 19:01:53 INFO - Blob upload gear active. 19:01:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:01:53 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 19:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:01:53 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:01:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:54 INFO - (blobuploader) - INFO - Done attempting. 19:01:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:01:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:01:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:55 INFO - (blobuploader) - INFO - Done attempting. 19:01:55 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:55 INFO - Return code: 0 19:01:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:01:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b964dd3065f459e76ea4fe831b6b61aaed064f5c7768e54f46800b8c53a8a5ef97c5757966c0be2e0673ab566c991845113732ff1ee9fde8f1b79b38d99f2fa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02453b97c333b661d01a7f96fed3dd327769e3198b5df46f97796f0a40a11e8a636e788b057a712a845d3dcf6aa5431098b3036572b377b10bbb227cc4c0572c"} 19:01:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:01:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:01:55 INFO - Contents: 19:01:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b964dd3065f459e76ea4fe831b6b61aaed064f5c7768e54f46800b8c53a8a5ef97c5757966c0be2e0673ab566c991845113732ff1ee9fde8f1b79b38d99f2fa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02453b97c333b661d01a7f96fed3dd327769e3198b5df46f97796f0a40a11e8a636e788b057a712a845d3dcf6aa5431098b3036572b377b10bbb227cc4c0572c"} 19:01:55 INFO - Running post-run listener: copy_logs_to_upload_dir 19:01:55 INFO - Copying logs to upload dir... 19:01:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:01:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.160200 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-02-24 19:01:55.570157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 19:01:55.574126) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b964dd3065f459e76ea4fe831b6b61aaed064f5c7768e54f46800b8c53a8a5ef97c5757966c0be2e0673ab566c991845113732ff1ee9fde8f1b79b38d99f2fa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02453b97c333b661d01a7f96fed3dd327769e3198b5df46f97796f0a40a11e8a636e788b057a712a845d3dcf6aa5431098b3036572b377b10bbb227cc4c0572c"} build_url:https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011166 build_url: 'https://queue.taskcluster.net/v1/task/HuieNmHHSV6N9g9iAqyMTg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b964dd3065f459e76ea4fe831b6b61aaed064f5c7768e54f46800b8c53a8a5ef97c5757966c0be2e0673ab566c991845113732ff1ee9fde8f1b79b38d99f2fa1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/02453b97c333b661d01a7f96fed3dd327769e3198b5df46f97796f0a40a11e8a636e788b057a712a845d3dcf6aa5431098b3036572b377b10bbb227cc4c0572c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 19:01:55.599033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:01:55.599452) ========= 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=5bd038846534b2fdfa68eeae000001e2-1456367484.4892-2030177368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:01:55.684613) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 19:01:55.684937) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 19:01:55.685241) ========= ========= Total master_lag: 0.26 =========