builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1454381475.55 results: success (0) buildid: 20160201161019 builduid: c8d00bf2f8e346559045d3946233336e revision: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.545829) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.546402) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.546880) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006405 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.569958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.570262) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.583371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.583648) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.633086) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.633374) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.633719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:15.634010) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-01 18:51:15-- 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% 44.8K=0.3s 2016-02-01 18:51:16 (44.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.395457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.042124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.042448) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015763 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.091620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.091927) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 --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 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 --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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-01 18:51:16,284 truncating revision to first 12 chars 2016-02-01 18:51:16,284 Setting DEBUG logging. 2016-02-01 18:51:16,284 attempt 1/10 2016-02-01 18:51:16,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/980fea2f7011?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-01 18:51:16,547 unpacking tar archive at: mozilla-aurora-980fea2f7011/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.656774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.657078) ========= echo 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'980fea2f7011680074bf2f0941ee7e5d0eb3c4a3'] 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 program finished with exit code 0 elapsedTime=0.004040 script_repo_revision: '980fea2f7011680074bf2f0941ee7e5d0eb3c4a3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.708640) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.708924) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-01 18:51:16.720034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-01 18:51:16.720319) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:51:16 INFO - MultiFileLogger online at 20160201 18:51:16 in /builds/slave/test-pgo 18:51:16 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:51:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:51:17 INFO - {'append_to_log': False, 18:51:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:51:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:51:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:51:17 INFO - 'branch': 'Mozilla-Aurora', 18:51:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:51:17 INFO - 'config_files': ('talos/linux_config.py',), 18:51:17 INFO - 'default_actions': ('clobber', 18:51:17 INFO - 'read-buildbot-config', 18:51:17 INFO - 'download-and-extract', 18:51:17 INFO - 'populate-webroot', 18:51:17 INFO - 'create-virtualenv', 18:51:17 INFO - 'install', 18:51:17 INFO - 'run-tests'), 18:51:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:51:17 INFO - 'download_minidump_stackwalk': True, 18:51:17 INFO - 'download_symbols': 'ondemand', 18:51:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:51:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:51:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:51:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:51:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:51:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:51:17 INFO - 'installer_path': 'installer.exe', 18:51:17 INFO - 'log_level': 'info', 18:51:17 INFO - 'log_name': 'talos', 18:51:17 INFO - 'log_to_console': True, 18:51:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:51:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:51:17 INFO - 'opt_config_files': (), 18:51:17 INFO - 'pip_index': False, 18:51:17 INFO - 'sps_profile': False, 18:51:17 INFO - 'sps_profile_interval': 0, 18:51:17 INFO - 'suite': 'dromaeojs-e10s', 18:51:17 INFO - 'system_bits': '32', 18:51:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:51:17 INFO - 'title': 'talos-linux64-ix-006', 18:51:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:51:17 INFO - 'use_talos_json': True, 18:51:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:51:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:51:17 INFO - 'work_dir': 'build'} 18:51:17 INFO - ##### 18:51:17 INFO - ##### Running clobber step. 18:51:17 INFO - ##### 18:51:17 INFO - Running pre-action listener: _resource_record_pre_action 18:51:17 INFO - Running main action method: clobber 18:51:17 INFO - rmtree: /builds/slave/test-pgo/build 18:51:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:51:17 INFO - Running post-action listener: _resource_record_post_action 18:51:17 INFO - ##### 18:51:17 INFO - ##### Running read-buildbot-config step. 18:51:17 INFO - ##### 18:51:17 INFO - Running pre-action listener: _resource_record_pre_action 18:51:17 INFO - Running main action method: read_buildbot_config 18:51:17 INFO - Using buildbot properties: 18:51:17 INFO - { 18:51:17 INFO - "project": "", 18:51:17 INFO - "product": "firefox", 18:51:17 INFO - "script_repo_revision": "production", 18:51:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:51:17 INFO - "repository": "", 18:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:51:17 INFO - "buildid": "20160201161019", 18:51:17 INFO - "pgo_build": "True", 18:51:17 INFO - "basedir": "/builds/slave/test-pgo", 18:51:17 INFO - "buildnumber": 25, 18:51:17 INFO - "slavename": "talos-linux64-ix-006", 18:51:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:51:17 INFO - "platform": "ubuntu64_hw", 18:51:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:51:17 INFO - "branch": "mozilla-aurora", 18:51:17 INFO - "repo_path": "releases/mozilla-aurora", 18:51:17 INFO - "revision": "980fea2f7011680074bf2f0941ee7e5d0eb3c4a3", 18:51:17 INFO - "stage_platform": "linux64-pgo", 18:51:17 INFO - "builduid": "c8d00bf2f8e346559045d3946233336e", 18:51:17 INFO - "slavebuilddir": "test" 18:51:17 INFO - } 18:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 18:51:17 INFO - Running post-action listener: _resource_record_post_action 18:51:17 INFO - ##### 18:51:17 INFO - ##### Running download-and-extract step. 18:51:17 INFO - ##### 18:51:17 INFO - Running pre-action listener: _resource_record_pre_action 18:51:17 INFO - Running main action method: download_and_extract 18:51:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:17 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json 18:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json 18:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:51:22 INFO - Downloaded 1448 bytes. 18:51:22 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:51:22 INFO - Using the following test package requirements: 18:51:22 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:51:22 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:51:22 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:51:22 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'jsshell-linux-x86_64.zip'], 18:51:22 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:51:22 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:51:22 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:51:22 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:51:22 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:51:22 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 18:51:22 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 18:51:22 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:51:22 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:22 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:51:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:51:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:51:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:23 INFO - Downloaded 22398540 bytes. 18:51:23 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:51:23 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:51:25 INFO - Return code: 0 18:51:25 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:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:25 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 18:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:26 INFO - Downloaded 22398540 bytes. 18:51:26 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:51:26 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:51:28 INFO - Return code: 0 18:51:28 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:51:28 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 18:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:29 INFO - Downloaded 10706572 bytes. 18:51:29 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:51:29 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:51:29 INFO - Return code: 0 18:51:29 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:51:29 INFO - https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:51:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:51:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:51:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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:51:31 INFO - Downloaded 59583586 bytes. 18:51:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:51:31 INFO - mkdir: /builds/slave/test-pgo/properties 18:51:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:51:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:51:31 INFO - Contents: 18:51:31 INFO - build_url:https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 18:51:31 INFO - Running post-action listener: _resource_record_post_action 18:51:31 INFO - Running post-action listener: set_extra_try_arguments 18:51:31 INFO - ##### 18:51:31 INFO - ##### Running populate-webroot step. 18:51:31 INFO - ##### 18:51:31 INFO - Running pre-action listener: _resource_record_pre_action 18:51:31 INFO - Running main action method: populate_webroot 18:51:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:31 INFO - '--tppagecycles', 18:51:31 INFO - '7'], 18:51:31 INFO - 'tests': ['tsvgm']}}, 18:51:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:51:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:51:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'tests': ['damp', 'tps']}, 18:51:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['damp', 'tps']}, 18:51:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:51:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:31 INFO - 'other': {'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'other_l64': {'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'other_nol64': {'tests': ['a11yr', 18:51:31 INFO - 'ts_paint', 18:51:31 INFO - 'tpaint', 18:51:31 INFO - 'sessionrestore', 18:51:31 INFO - 'sessionrestore_no_auto_restore']}, 18:51:31 INFO - 'svgr': {'tests': ['tsvgx', 18:51:31 INFO - 'tsvgr_opacity', 18:51:31 INFO - 'tart', 18:51:31 INFO - 'tscrollx', 18:51:31 INFO - 'cart']}, 18:51:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['tsvgx', 18:51:31 INFO - 'tsvgr_opacity', 18:51:31 INFO - 'tart', 18:51:31 INFO - 'tscrollx', 18:51:31 INFO - 'cart']}, 18:51:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'tests': ['tp5o']}, 18:51:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'talos_options': ['--e10s'], 18:51:31 INFO - 'tests': ['tp5o']}, 18:51:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'talos_options': ['--xperf_path', 18:51:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:31 INFO - 'tests': ['tp5n']}, 18:51:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:51:31 INFO - 'talos_options': ['--e10s', 18:51:31 INFO - '--xperf_path', 18:51:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:31 INFO - 'tests': ['tp5n']}}, 18:51:31 INFO - 'talos.zip': {'path': '', 18:51:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:31 INFO - Running post-action listener: _resource_record_post_action 18:51:31 INFO - ##### 18:51:31 INFO - ##### Running create-virtualenv step. 18:51:31 INFO - ##### 18:51:31 INFO - Running pre-action listener: _resource_record_pre_action 18:51:31 INFO - Running main action method: create_virtualenv 18:51:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:51:31 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:51:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:51:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:31 INFO - Using real prefix '/usr' 18:51:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:51:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:33 INFO - Installing pip.................done. 18:51:33 INFO - Return code: 0 18:51:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:51: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:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:33 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:33 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:51:33 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:51:33 INFO - Using env: {'DISPLAY': ':0', 18:51:33 INFO - 'HOME': '/home/cltbld', 18:51:33 INFO - 'LANG': 'en_US.UTF-8', 18:51:33 INFO - 'LANGUAGE': 'en_US:en', 18:51:33 INFO - 'LOGNAME': 'cltbld', 18:51:33 INFO - 'MAIL': '/var/mail/cltbld', 18:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:33 INFO - 'MOZ_NO_REMOTE': '1', 18:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:33 INFO - 'NO_EM_RESTART': '1', 18:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:33 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:33 INFO - 'SHELL': '/bin/bash', 18:51:33 INFO - 'SHLVL': '1', 18:51:33 INFO - 'TERM': 'linux', 18:51:33 INFO - 'TMOUT': '86400', 18:51:33 INFO - 'USER': 'cltbld', 18:51:33 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:33 INFO - '_': '/tools/buildbot/bin/python'} 18:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:34 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:51:34 INFO - Cleaning up... 18:51:34 INFO - Return code: 0 18:51:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:34 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:34 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:51:34 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:51:34 INFO - Using env: {'DISPLAY': ':0', 18:51:34 INFO - 'HOME': '/home/cltbld', 18:51:34 INFO - 'LANG': 'en_US.UTF-8', 18:51:34 INFO - 'LANGUAGE': 'en_US:en', 18:51:34 INFO - 'LOGNAME': 'cltbld', 18:51:34 INFO - 'MAIL': '/var/mail/cltbld', 18:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:34 INFO - 'MOZ_NO_REMOTE': '1', 18:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:34 INFO - 'NO_EM_RESTART': '1', 18:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:34 INFO - 'SHELL': '/bin/bash', 18:51:34 INFO - 'SHLVL': '1', 18:51:34 INFO - 'TERM': 'linux', 18:51:34 INFO - 'TMOUT': '86400', 18:51:34 INFO - 'USER': 'cltbld', 18:51:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:34 INFO - '_': '/tools/buildbot/bin/python'} 18:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:34 INFO - Downloading/unpacking psutil>=0.7.1 18:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:34 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:51:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:36 INFO - Installing collected packages: psutil 18:51:36 INFO - Running setup.py install for psutil 18:51:36 INFO - building 'psutil._psutil_linux' extension 18:51:36 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:51:36 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:51:36 INFO - building 'psutil._psutil_posix' extension 18:51:36 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:51:36 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:51:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:36 INFO - Successfully installed psutil 18:51:36 INFO - Cleaning up... 18:51:36 INFO - Return code: 0 18:51:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:36 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:36 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:51:36 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:51:36 INFO - Using env: {'DISPLAY': ':0', 18:51:36 INFO - 'HOME': '/home/cltbld', 18:51:36 INFO - 'LANG': 'en_US.UTF-8', 18:51:36 INFO - 'LANGUAGE': 'en_US:en', 18:51:36 INFO - 'LOGNAME': 'cltbld', 18:51:36 INFO - 'MAIL': '/var/mail/cltbld', 18:51:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:36 INFO - 'MOZ_NO_REMOTE': '1', 18:51:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:36 INFO - 'NO_EM_RESTART': '1', 18:51:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:36 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:36 INFO - 'SHELL': '/bin/bash', 18:51:36 INFO - 'SHLVL': '1', 18:51:36 INFO - 'TERM': 'linux', 18:51:36 INFO - 'TMOUT': '86400', 18:51:36 INFO - 'USER': 'cltbld', 18:51:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:36 INFO - '_': '/tools/buildbot/bin/python'} 18:51:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:36 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:51:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:51:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:38 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:51:38 INFO - Installing collected packages: mozsystemmonitor 18:51:38 INFO - Running setup.py install for mozsystemmonitor 18:51:38 INFO - Successfully installed mozsystemmonitor 18:51:38 INFO - Cleaning up... 18:51:38 INFO - Return code: 0 18:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:51: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:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:38 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:38 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:51:38 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:51:38 INFO - Using env: {'DISPLAY': ':0', 18:51:38 INFO - 'HOME': '/home/cltbld', 18:51:38 INFO - 'LANG': 'en_US.UTF-8', 18:51:38 INFO - 'LANGUAGE': 'en_US:en', 18:51:38 INFO - 'LOGNAME': 'cltbld', 18:51:38 INFO - 'MAIL': '/var/mail/cltbld', 18:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:38 INFO - 'MOZ_NO_REMOTE': '1', 18:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:38 INFO - 'NO_EM_RESTART': '1', 18:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:38 INFO - 'SHELL': '/bin/bash', 18:51:38 INFO - 'SHLVL': '1', 18:51:38 INFO - 'TERM': 'linux', 18:51:38 INFO - 'TMOUT': '86400', 18:51:38 INFO - 'USER': 'cltbld', 18:51:38 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:38 INFO - '_': '/tools/buildbot/bin/python'} 18:51:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:39 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:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51:40 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:51:40 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:51:40 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:51:40 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:51:40 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:51:40 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:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:51:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:41 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:51:41 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:51:41 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:51:41 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:51:41 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:51:41 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:51:41 INFO - Downloading docopt-0.6.1.tar.gz 18:51:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:41 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:41 INFO - Running setup.py install for blobuploader 18:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:41 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:51:41 INFO - Running setup.py install for requests 18:51:42 INFO - Running setup.py install for docopt 18:51:42 INFO - Successfully installed blobuploader requests docopt 18:51:42 INFO - Cleaning up... 18:51:42 INFO - Return code: 0 18:51:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:51:42 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:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:42 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:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:42 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:42 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:51:42 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:51:42 INFO - Using env: {'DISPLAY': ':0', 18:51:42 INFO - 'HOME': '/home/cltbld', 18:51:42 INFO - 'LANG': 'en_US.UTF-8', 18:51:42 INFO - 'LANGUAGE': 'en_US:en', 18:51:42 INFO - 'LOGNAME': 'cltbld', 18:51:42 INFO - 'MAIL': '/var/mail/cltbld', 18:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:42 INFO - 'MOZ_NO_REMOTE': '1', 18:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:42 INFO - 'NO_EM_RESTART': '1', 18:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:42 INFO - 'SHELL': '/bin/bash', 18:51:42 INFO - 'SHLVL': '1', 18:51:42 INFO - 'TERM': 'linux', 18:51:42 INFO - 'TMOUT': '86400', 18:51:42 INFO - 'USER': 'cltbld', 18:51:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:42 INFO - '_': '/tools/buildbot/bin/python'} 18:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:42 INFO - Running setup.py (path:/tmp/pip-BDw451-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:42 INFO - Running setup.py (path:/tmp/pip-BhypAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:42 INFO - Running setup.py (path:/tmp/pip-WepXQI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:42 INFO - Running setup.py (path:/tmp/pip-YY4BGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:42 INFO - Running setup.py (path:/tmp/pip-HY4Zwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:42 INFO - Running setup.py (path:/tmp/pip-e7jgSY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:42 INFO - Running setup.py (path:/tmp/pip-sKkJEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:42 INFO - Running setup.py (path:/tmp/pip-174DbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:43 INFO - Running setup.py (path:/tmp/pip-ZHubAl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:43 INFO - Running setup.py (path:/tmp/pip-9JT_KQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:43 INFO - Running setup.py (path:/tmp/pip-5ZXcg4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:43 INFO - Running setup.py (path:/tmp/pip-5RUon4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:43 INFO - Running setup.py (path:/tmp/pip-PEVopH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:43 INFO - Running setup.py (path:/tmp/pip-qSSUGa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:43 INFO - Running setup.py (path:/tmp/pip-0Kx0A_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:43 INFO - Running setup.py (path:/tmp/pip-_0Lksf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:43 INFO - Running setup.py (path:/tmp/pip-Fejx0z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:43 INFO - Running setup.py install for manifestparser 18:51:43 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:51:43 INFO - Running setup.py install for mozcrash 18:51:43 INFO - Running setup.py install for mozdebug 18:51:43 INFO - Running setup.py install for mozdevice 18:51:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for mozfile 18:51:44 INFO - Running setup.py install for mozhttpd 18:51:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for mozinfo 18:51:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for mozInstall 18:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for mozleak 18:51:44 INFO - Running setup.py install for mozlog 18:51:44 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for moznetwork 18:51:44 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:51:44 INFO - Running setup.py install for mozprocess 18:51:44 INFO - Running setup.py install for mozprofile 18:51:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:51:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:51:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:51:45 INFO - Running setup.py install for mozrunner 18:51:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:51:45 INFO - Running setup.py install for mozscreenshot 18:51:45 INFO - Running setup.py install for moztest 18:51:45 INFO - Running setup.py install for mozversion 18:51:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:45 INFO - Cleaning up... 18:51:45 INFO - Return code: 0 18:51:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:45 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:51:45 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:51:45 INFO - Using env: {'DISPLAY': ':0', 18:51:45 INFO - 'HOME': '/home/cltbld', 18:51:45 INFO - 'LANG': 'en_US.UTF-8', 18:51:45 INFO - 'LANGUAGE': 'en_US:en', 18:51:45 INFO - 'LOGNAME': 'cltbld', 18:51:45 INFO - 'MAIL': '/var/mail/cltbld', 18:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:45 INFO - 'MOZ_NO_REMOTE': '1', 18:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:45 INFO - 'NO_EM_RESTART': '1', 18:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:45 INFO - 'SHELL': '/bin/bash', 18:51:45 INFO - 'SHLVL': '1', 18:51:45 INFO - 'TERM': 'linux', 18:51:45 INFO - 'TMOUT': '86400', 18:51:45 INFO - 'USER': 'cltbld', 18:51:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:45 INFO - '_': '/tools/buildbot/bin/python'} 18:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:45 INFO - Running setup.py (path:/tmp/pip-BmIMQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:51:45 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:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:45 INFO - Running setup.py (path:/tmp/pip-iis4vJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:51:45 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:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:45 INFO - Running setup.py (path:/tmp/pip-4kQzGZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:51:45 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:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:45 INFO - Running setup.py (path:/tmp/pip-kfmDyY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:51:45 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:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:45 INFO - Running setup.py (path:/tmp/pip-GXoXmF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:46 INFO - Running setup.py (path:/tmp/pip-rKCQ1L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:46 INFO - Running setup.py (path:/tmp/pip-IYv15a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:46 INFO - Running setup.py (path:/tmp/pip-rubPIs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:46 INFO - Running setup.py (path:/tmp/pip-kpwugi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:46 INFO - Running setup.py (path:/tmp/pip-_TI0ek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:46 INFO - Running setup.py (path:/tmp/pip-7c_msA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:46 INFO - Running setup.py (path:/tmp/pip-uLD7ZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:46 INFO - Running setup.py (path:/tmp/pip-JhrlVt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:46 INFO - Running setup.py (path:/tmp/pip-QQvBrb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:46 INFO - Running setup.py (path:/tmp/pip-7n1r3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:46 INFO - Running setup.py (path:/tmp/pip-6YP2yF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:51:46 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:51:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:46 INFO - Running setup.py (path:/tmp/pip-Rudb0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 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:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:48 INFO - Downloading blessings-1.6.tar.gz 18:51:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:48 INFO - Installing collected packages: blessings 18:51:48 INFO - Running setup.py install for blessings 18:51:48 INFO - Successfully installed blessings 18:51:48 INFO - Cleaning up... 18:51:48 INFO - Return code: 0 18:51:48 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:51:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:51:49 INFO - Reading from file tmpfile_stdout 18:51:49 INFO - Current package versions: 18:51:49 INFO - argparse == 1.2.1 18:51:49 INFO - blessings == 1.6 18:51:49 INFO - blobuploader == 1.2.4 18:51:49 INFO - docopt == 0.6.1 18:51:49 INFO - manifestparser == 1.1 18:51:49 INFO - mozInstall == 1.12 18:51:49 INFO - mozcrash == 0.16 18:51:49 INFO - mozdebug == 0.1 18:51:49 INFO - mozdevice == 0.48 18:51:49 INFO - mozfile == 1.2 18:51:49 INFO - mozhttpd == 0.7 18:51:49 INFO - mozinfo == 0.9 18:51:49 INFO - mozleak == 0.1 18:51:49 INFO - mozlog == 3.1 18:51:49 INFO - moznetwork == 0.27 18:51:49 INFO - mozprocess == 0.22 18:51:49 INFO - mozprofile == 0.28 18:51:49 INFO - mozrunner == 6.11 18:51:49 INFO - mozscreenshot == 0.1 18:51:49 INFO - mozsystemmonitor == 0.0 18:51:49 INFO - moztest == 0.7 18:51:49 INFO - mozversion == 1.4 18:51:49 INFO - psutil == 3.1.1 18:51:49 INFO - requests == 1.2.3 18:51:49 INFO - wsgiref == 0.1.2 18:51:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:49 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:51:49 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:51:49 INFO - Using env: {'DISPLAY': ':0', 18:51:49 INFO - 'HOME': '/home/cltbld', 18:51:49 INFO - 'LANG': 'en_US.UTF-8', 18:51:49 INFO - 'LANGUAGE': 'en_US:en', 18:51:49 INFO - 'LOGNAME': 'cltbld', 18:51:49 INFO - 'MAIL': '/var/mail/cltbld', 18:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:49 INFO - 'MOZ_NO_REMOTE': '1', 18:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:49 INFO - 'NO_EM_RESTART': '1', 18:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:49 INFO - 'SHELL': '/bin/bash', 18:51:49 INFO - 'SHLVL': '1', 18:51:49 INFO - 'TERM': 'linux', 18:51:49 INFO - 'TMOUT': '86400', 18:51:49 INFO - 'USER': 'cltbld', 18:51:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:49 INFO - '_': '/tools/buildbot/bin/python'} 18:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 INFO - Cleaning up... 18:51:49 INFO - Return code: 0 18:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:49 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:49 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:51:49 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:51:49 INFO - Using env: {'DISPLAY': ':0', 18:51:49 INFO - 'HOME': '/home/cltbld', 18:51:49 INFO - 'LANG': 'en_US.UTF-8', 18:51:49 INFO - 'LANGUAGE': 'en_US:en', 18:51:49 INFO - 'LOGNAME': 'cltbld', 18:51:49 INFO - 'MAIL': '/var/mail/cltbld', 18:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:49 INFO - 'MOZ_NO_REMOTE': '1', 18:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:49 INFO - 'NO_EM_RESTART': '1', 18:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:49 INFO - 'SHELL': '/bin/bash', 18:51:49 INFO - 'SHLVL': '1', 18:51:49 INFO - 'TERM': 'linux', 18:51:49 INFO - 'TMOUT': '86400', 18:51:49 INFO - 'USER': 'cltbld', 18:51:49 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:49 INFO - '_': '/tools/buildbot/bin/python'} 18:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:49 INFO - Downloading/unpacking jsonschema 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:51:51 INFO - Downloading/unpacking functools32 (from jsonschema) 18:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:51 INFO - Downloading functools32-3.2.3-2.tar.gz 18:51:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:51:51 INFO - warning: no files found matching '*.txt' 18:51:51 INFO - no previously-included directories found matching 'build' 18:51:51 INFO - no previously-included directories found matching 'dist' 18:51:51 INFO - no previously-included directories found matching '.git*' 18:51:51 INFO - Installing collected packages: jsonschema, functools32 18:51:51 INFO - Running setup.py install for functools32 18:51:51 INFO - warning: no files found matching '*.txt' 18:51:51 INFO - no previously-included directories found matching 'build' 18:51:51 INFO - no previously-included directories found matching 'dist' 18:51:51 INFO - no previously-included directories found matching '.git*' 18:51:51 INFO - Successfully installed jsonschema functools32 18:51:51 INFO - Cleaning up... 18:51:51 INFO - Return code: 0 18:51:51 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:51 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 0x7f9fc1b89f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18f6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', '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:51:51 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:51:51 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:51:51 INFO - Using env: {'DISPLAY': ':0', 18:51:51 INFO - 'HOME': '/home/cltbld', 18:51:51 INFO - 'LANG': 'en_US.UTF-8', 18:51:51 INFO - 'LANGUAGE': 'en_US:en', 18:51:51 INFO - 'LOGNAME': 'cltbld', 18:51:51 INFO - 'MAIL': '/var/mail/cltbld', 18:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:51 INFO - 'MOZ_NO_REMOTE': '1', 18:51:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:51:51 INFO - 'NO_EM_RESTART': '1', 18:51:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:51:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:51:51 INFO - 'SHELL': '/bin/bash', 18:51:51 INFO - 'SHLVL': '1', 18:51:51 INFO - 'TERM': 'linux', 18:51:51 INFO - 'TMOUT': '86400', 18:51:51 INFO - 'USER': 'cltbld', 18:51:51 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:51 INFO - '_': '/tools/buildbot/bin/python'} 18:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:52 INFO - Downloading/unpacking flake8 18:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:51:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:51:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:51:54 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:51:54 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:51:54 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:51:54 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:51:54 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:51:54 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:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:51:54 INFO - no previously-included directories found matching 'docs/_build' 18:51:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:51:54 INFO - Running setup.py install for pep8 18:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:51:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:51:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:51:54 INFO - no previously-included directories found matching 'docs/_build' 18:51:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:51:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:51:54 INFO - Cleaning up... 18:51:54 INFO - Return code: 0 18:51:54 INFO - Running post-action listener: _resource_record_post_action 18:51:54 INFO - Running post-action listener: _start_resource_monitoring 18:51:54 INFO - Starting resource monitoring. 18:51:54 INFO - ##### 18:51:54 INFO - ##### Running install step. 18:51:54 INFO - ##### 18:51:54 INFO - Running pre-action listener: _resource_record_pre_action 18:51:54 INFO - Running main action method: install 18:51:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:51:54 INFO - Reading from file tmpfile_stdout 18:51:54 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:51:55 INFO - Reading from file tmpfile_stdout 18:51:55 INFO - Output received: 18:51:55 INFO - Usage: mozinstall [options] installer 18:51:55 INFO - Options: 18:51:55 INFO - -h, --help show this help message and exit 18:51:55 INFO - -d DEST, --destination=DEST 18:51:55 INFO - Directory to install application into. [default: 18:51:55 INFO - "/builds/slave/test-pgo"] 18:51:55 INFO - --app=APP Application being installed. [default: firefox] 18:51:55 INFO - mkdir: /builds/slave/test-pgo/build/application 18:51:55 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:51:55 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:52:09 INFO - Reading from file tmpfile_stdout 18:52:09 INFO - Output received: 18:52:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:52:09 INFO - Running post-action listener: _resource_record_post_action 18:52:09 INFO - ##### 18:52:09 INFO - ##### Running run-tests step. 18:52:09 INFO - ##### 18:52:09 INFO - Running pre-action listener: _resource_record_pre_action 18:52:09 INFO - Running main action method: run_tests 18:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:52:09 INFO - Python 2.7.3 18:52:09 INFO - Return code: 0 18:52:09 INFO - grabbing minidump binary from tooltool 18:52:09 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:52:09 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 0x1985660>, '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 0x1986560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1986a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:52:09 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:52:09 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:52:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:10 INFO - Return code: 0 18:52:10 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:52:10 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:52:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:52:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:52:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:52:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:52:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:52:11 INFO - Return code: 0 18:52:11 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:52:11 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:52:11 INFO - Using env: {'DISPLAY': ':0', 18:52:11 INFO - 'HOME': '/home/cltbld', 18:52:11 INFO - 'LANG': 'en_US.UTF-8', 18:52:11 INFO - 'LANGUAGE': 'en_US:en', 18:52:11 INFO - 'LOGNAME': 'cltbld', 18:52:11 INFO - 'MAIL': '/var/mail/cltbld', 18:52:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:52:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:11 INFO - 'MOZ_NO_REMOTE': '1', 18:52:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:52:11 INFO - 'NO_EM_RESTART': '1', 18:52:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:52:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:52:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:52:11 INFO - 'SHELL': '/bin/bash', 18:52:11 INFO - 'SHLVL': '1', 18:52:11 INFO - 'TERM': 'linux', 18:52:11 INFO - 'TMOUT': '86400', 18:52:11 INFO - 'USER': 'cltbld', 18:52:11 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920', 18:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:11 INFO - '_': '/tools/buildbot/bin/python'} 18:52:11 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/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:52:11 INFO - mozversion application_buildid: 20160201161019 18:52:11 INFO - mozversion application_changeset: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 18:52:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:52:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:11 INFO - mozversion application_name: Firefox 18:52:11 INFO - mozversion application_remotingname: firefox-dev 18:52:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:52:11 INFO - mozversion application_vendor: Mozilla 18:52:11 INFO - mozversion application_version: 46.0a2 18:52:11 INFO - mozversion platform_buildid: 20160201161019 18:52:11 INFO - mozversion platform_changeset: 980fea2f7011680074bf2f0941ee7e5d0eb3c4a3 18:52:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:52:11 INFO - mozversion platform_version: 46.0a2 18:52:11 INFO - using testdate: 1454381531 18:52:11 INFO - actual date: 1454381531 18:52:11 INFO - starting webserver on 'localhost:60014' 18:52:11 INFO - SUITE-START | Running 3 tests 18:52:11 INFO - TEST-START | dromaeo_css 18:52:11 INFO - operating with platform_type : linux_ 18:52:11 INFO - Initialising browser for dromaeo_css test... 18:52:11 INFO - TEST-INFO | started process 29368 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCL1h3g/profile http://localhost:60014/getInfo.html) 18:52:14 INFO - PROCESS | 29368 | 18:52:14 INFO - PROCESS | 29368 | (process:29449): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:52:15 INFO - PROCESS | 29368 | __metrics Screen width/height:1600/1200 18:52:15 INFO - PROCESS | 29368 | colorDepth:24 18:52:15 INFO - PROCESS | 29368 | Browser inner width/height: 1024/697 18:52:15 INFO - PROCESS | 29368 | __metrics 18:52:16 INFO - TEST-INFO | 29368: exit 0 18:52:16 INFO - Browser initialized. 18:52:16 INFO - Running cycle 1/1 for dromaeo_css test... 18:52:16 INFO - TEST-INFO | started process 29499 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCL1h3g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:18 INFO - PROCESS | 29499 | 18:52:18 INFO - PROCESS | 29499 | (process:29566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:52:28 INFO - PROCESS | 29499 | RSS: Main: 139665408 18:52:28 INFO - PROCESS | 29499 | 18:53:18 INFO - PROCESS | 29499 | 1454381598265 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:55:26 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60014/tests/dromaeo/cssquery-ext.html) 18:55:27 INFO - PROCESS | 29499 | RSS: Main: 144814080 18:55:27 INFO - PROCESS | 29499 | 18:58:29 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-ext.html (next: http://localhost:60014/tests/dromaeo/cssquery-jquery.html) 18:58:29 INFO - PROCESS | 29499 | RSS: Main: 144105472 18:58:29 INFO - PROCESS | 29499 | 19:01:31 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60014/tests/dromaeo/cssquery-mootools.html) 19:01:32 INFO - PROCESS | 29499 | RSS: Main: 143179776 19:01:32 INFO - PROCESS | 29499 | 19:04:33 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60014/tests/dromaeo/cssquery-prototype.html) 19:04:34 INFO - PROCESS | 29499 | RSS: Main: 142721024 19:04:34 INFO - PROCESS | 29499 | 19:07:36 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60014/tests/dromaeo/cssquery-yui.html) 19:07:37 INFO - PROCESS | 29499 | RSS: Main: 142966784 19:07:37 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | Cycle 1(1): loaded http://localhost:60014/tests/dromaeo/cssquery-yui.html (next: http://localhost:60014/tests/dromaeo/cssquery-dojo.html) 19:10:39 INFO - PROCESS | 29499 | RSS: Main: 146067456 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | __start_tp_report 19:10:39 INFO - PROCESS | 29499 | _x_x_mozilla_page_load 19:10:39 INFO - PROCESS | 29499 | _x_x_mozilla_page_load_details 19:10:39 INFO - PROCESS | 29499 | |i|pagename|runs| 19:10:39 INFO - PROCESS | 29499 | |0;dojo.html;3313.801171929684;3374.9325013499715;3398.184435735421;3406.50605662179;3413.368526822538;5469.863253418666;5497.230387745713;5504.422035686251;5505.311836020497;5525.11598144297;5406.297181366417;5497.835064948058;5510.9448905510935;5516.558675305976;5538.363088244843;4979.576735977446;5027.698338099707;5089.51649593288;5113.846584602468;5115.565176959963;4891.902161956758;4989.351384320052;5081.060003899291;5085.059264036166;5150.587952963754;5024.819167495635;5073.289739436464;5122.564582010534;5124.052050370675;5130.743462826862;5029.295898574221;5040.59675225981;5058.064258112261;5072.442031376546;5073.0614836255045;4951.8266860659705;4962.826301079481;4976.601871850244;4986.650934434591;5023.8492845214705;5242.23987521811;5287.788488460457;5295.523402893758;5322.467753224685;5348.090824559834;5894.086416605433;5937.732802023919;5952.3154837193415;5957.255343082114;5967.19442875215;5785.88428231433;5883;5908.261467316585;5931.051031834929;6012.939870601325;5612.382637909826;5638.577106717013;5647.858803529944;5654.123610840326;5654.349749778787;6069.757209711651;6086;6092.238470191226;6101.450869421773;6101.481374083252;5773.538116950634;5849.239598852122;5861.267341582302;5922.585419020627;5956.1065840123465;5930.495907847881;5948.078047902582;5949.583529153005;5959.344472108065;5960.1059841023325;5737.65574065549;5884.176215329857;5915.911261330997;5929.229200203946;5934.020886553757;5782.797602083907;5884.411558844167;5916.2013128228;5934.287885453773;5944.970275148597;4466.553344665573;4481.081378317437;4482.282834746425;4488.753118578509;4503.234450143484;4015.8996025099605;4022;4055.270051390719;4065.4308396824467;4086.7752273625238;5630.85922851932;5685.0619647758485;5685.60200785941;5689.288838895138;5713.314402271754;5885.499732522698;5891.970540147272;5897.705114744332;5906.173135760997;5911.881762364815;5582.162675598693;5598.86002849932;5609.803656872072;5611.551075913917;5694.174344719992;5062.063518249136;5084.313617661568;5110.514501122388;5111.105556527667;5139.280500729901;6014.548908831855;6058.1215723719815;6080.908786368208;6088.634681919099;6120.204373431426;5882.5293976480925;5903.144044113579;5903.557233207613;5947.3457919627945;5964.343922168645;6142.7136481981925;6184.567080304516;6185.474234689922;6187.597806142587;6205.503559715302;5922.851928701817;5927.436893495111;5948.851278718067;5959.880802383841;5970.283565972111;5748.396418376177;5828.0966450200285;5832.12518122285;5851.736671849691;5976.491998180029;5740.741666624928;5792.362840087502;5792.681402522901;5807.419258074159;5836.854078648068;5765.740541675551;5767.307923049261;5779;5782.017057100219;5800.651960882361;5617.101263797773;5674.148877668383;5701.173329867229;5717.828465146053;5722.599418040697;5833.766649333979;5847.619904706351;5905.734241959036;5906.497947674496;5940.316863560746;5725.856853578527;5741.8564535886935;5762.567807414377;5765.250517432707;5766.961946849608 19:10:39 INFO - PROCESS | 29499 | |1;ext.html;524.1482590789966;561.3376216065042;566.8294970885122;570.4409678515055;635.9491240700744;29624;35957;36541.81729091354;36568.268634627355;36686.8165659172;40065.399019014665;40427.797861010724;40618.59381406185;40896.59103408965;40985.59014409855;8455.661773529051;8650.956745216265;8720.171583699539;8722.738317850442;8733.214010739031;8529.658813647447;8671;8671;8672.566371681422;8942.284617230605;8888.155625215626;8919.687810926618;8928.687495937644;8935.329850261223;8936.64253429862;8810;8832.160944710242;8851.336149788727;8869.201771840533;8934.64261429542;8763.12368763125;8891.644334226688;8906.376553641248;8939.374243802937;8940.061293564147;41575.1684966302;41911.1617767646;42001.1599768006;42065.579344206475;42164;3513.8067406292644;3570.357335679577;3793.2982398256136;4083.5916408358926;4340.370646256307;30564.388712225853;30736.077917662507;30864.53703194454;30974.845125774227;31822.681773182434;4058.147788964321;4103.302438585448;4146.343896186801;4206.242876282268;4246.214450326699;289027;290702;333003;336155;337097;58754.706226468596;58850.411495885346;58870;59493.40506594965;59514.70242648845;64124;64304;64427;64506.354936450974;64822;15987.920060399623;16102.275397607136;16223.432179873647;16298.10360430164;16307.918460407622;12751.42618582166;12809.359532023362;12827.102102852898;12839.935800321125;12845.100842941092;21454.46363840885;21629.351119466442;21809.781902181094;21858.781412185992;21947.231846885283;8594.828103437896;8869.246114080246;8887.777805554784;8950.328725345626;8964.731058068268;1003.9247056470793;1035.9226404539195;1075.4945175767377;1103.9126460436464;1112.3937454087543;29875.253118672208;30215.395692086036;30239.395212095635;30494.54258186129;30522.69477305243;1157.1437136518916;1159.1644893082191;1167.1946357013633;1260.9495620175273;1282.2755143343982;15008.62478438026;15009.249537523081;15093.924530377497;15185.468508602145;15321.770173447407;527318;530581;537877;687578;706585;53257.733711331195;54244.45755542394;54326;54715;54715.17927231015;1436.6480212347833;1445.8337291211435;1454.8836093112525;1456.0826679192041;1475.5720840956003;29216.41567168687;33015.17462063371;33242.501362479095;33523.664763352055;33728.83135584307;50705.239421409446;52106;52156.73921630519;52525.47474525206;52634;328444;329773;332247;333394;333796;44497.55502444934;44721;45033;45137.77431112823;46134.30798538092;46633.30050049184;46924.296135558674;47398.526014739415;47565.28652070291;48476;40921.59078409178;41672.79163604163;41677.74435038213;42818.78590607027;42881.14237715291;39819;41742.79128604338;41840.58159418367;41868.1626367477;42115.1576968465;42231.577684222764;42612.5738742621;42632.360514592925;43046.139077218904;43780.34329485124;32008.199795005312;32426;33172;34344.313113738084;35128.47307290444;26450.470990579695;27181.320466988484;27189.86405067962;27227.59158612583;27433.58849617297 19:10:39 INFO - PROCESS | 29499 | |2;jquery.html;397.6957627415028;398.55162941690617;402.2979900074371;404.3671653861706;405.11482410932115;14276.928615356934;14789;17043.744343834853;17616.64766704665;17689.29242830287;10786.244962852603;11144.554217831277;14482;17197.570060748487;17259.82740172598;5043.546080852722;5157.690538567698;5616.52259557936;5619.269494965649;5627.184058311543;5155.3040339554245;5371.086915224421;5372.597055220855;5400.91898621521;5492.286002819628;5355.223492593572;5367.865803354928;5625.943740562583;6009.639421634694;6027.035674292114;6003.219581454383;6091.543134264925;6097.2683278006925;6282.277538083134;6348;5417.88933268679;5440.265564148829;5451.536619387357;5479.1781232815;5496.862578435531;15155.696886062216;20200.19199232029;20826.062827172664;20854.895725521426;20865.791342086537;2136.9252076177413;2201.1745595401726;2252.853564518301;2280.5096904165684;2304.1704986204954;10039.24705647072;10336.379817210991;12208.816867746991;13039.739205215843;13607.727845443134;1877.1646617255326;1890.2911408221917;1912.550550620617;1937.2251099560149;1969.7814229406372;51919;52003.219951700754;52383.73808130973;52660.73669631666;52680.736596317154;10673.412962286993;11135.665930022113;11150;11156;11201.943990280159;14332.211728354832;14469.92765036168;14470.710585788225;14490.637734056732;14532.854671453362;8171.63227654757;8175.509469431853;8236.217559331853;8306.460080094774;8338.832563441123;7883.36933045355;7891.802704932308;7906.683732650745;7970.840583188304;7983.640736166886;4596.517365676623;4716.198246298138;4825.396825396825;4833.081714474239;4881.8535443936735;1855.4248183063294;1931.1502938706924;1947.0362170725582;1947.7565304336958;1954.5309125809704;975.2734213011211;1043.2436483549366;1043.6973277749519;1117.4301106435614;1156.346664134761;17508.562285942953;17568.209430575655;17820.643587128186;18118.275268989357;18361.540961475803;982.597135174575;1000.6147633161286;1023.1201166996377;1024.114141267798;1075.5587512732975;10263.692089237335;10442;10468.63359782404;10470.37177769321;10493.317934334244;383100;388278;389189;573936;576894;69291.65354173197;73887.63056184792;73947;74101;77009;1107.3577325151232;1109.3066833229232;1230.8399908011902;1240.4913985265998;1274.4137696659454;10666.46667666629;16008.599785005468;16172.353105876104;16223.35106595723;16326.346946122498;33651.326973460884;34961.12597185091;35957.28085438329;36669.26661466809;39147;47346.52653473559;48798;49041.754791225816;49365.50634493609;50239.49760502348;10430.791384172122;10725.195610329101;10829.67510974672;10895.727606809893;11091.279066860629;3750.231202603405;6398.488120950406;6474.478497552977;8676;9033.096690330914;7910.920890791019;8250.298724608476;8262.628181731716;8334.166583341617;8435.493870367553;8195.034220912177;8360.12218717026;8481.87277190855;8600.870986935075;8605.440646357967;7473.804191329361;8065.677372905018;8299.585020749058;8484.109168537214;8513.489190648581;10271.794564108526;10811.675649730521;10934.559377792408;11000.614978476035;11149;10795.946020269848;10881.183911206534;10914.399708016135;10940.617078402218;11240.662780116609 19:10:39 INFO - PROCESS | 29499 | |3;mootools.html;1505.089420900355;1524.4435780939957;1716.8626509879202;1816.2916462579606;1855.4619160443472;8522.744317670473;8573.485590864553;8698.695545655903;8716.215540601344;8771.342149338801;8666.696665616704;8707.956460217705;8757.868631970525;8767.47395156291;8784.736457906258;2432.6594276801216;2448.902043918241;2450.9142180023705;2472.5054989002183;2473.480569080495;2478.938026549342;2576.6135079738;2582.573875310581;2598.701149367828;2610.6867175938914;2454.410941374066;2479.838810477313;2491.451880586268;2503.111395454615;2509.0591028364365;2406.8796560171922;2436.232586735173;2457.6682147910074;2463.8521688698734;2465.408302007523;2450.215930902112;2457.7665121813397;2463.285647162321;2474.480359124586;2486.3038349262238;8309.626066827008;8387.832243355098;8418.116097809703;8419.368547358912;8443.788905277355;5135.87160320995;5243.528082472596;5244.842654720364;5246.475352464761;5278.841634750964;3359.6136444308972;3393.355262500117;3404.0298514923375;3429.3998550253855;3449.034270404291;1045.7124290820009;1054.541274545575;1061.814182518064;1065.872095348563;1102.685734565645;11900.940495297555;12075.852793984644;12084.637460876187;12090.879091209063;12159.756804863942;4761.619070474354;4822.99999999993;4823.324734537167;4827.179379505493;4831.444383895827;10505.894941050492;10522.105621022145;10580;10587.629432969808;10603.946980265204;5274.235235890775;5327.946720532745;5340.839774806762;5343.465653434625;5354.063038968165;4786.545278198635;4861.829835955725;4873.31773551703;4881.121398148367;4881.414230292387;3895.3377925752125;3961.900952476211;3988.361862102108;3993.560708322082;4000.7999600020466;1227.472186959616;1239.0459346303476;1242.8757124287679;1243.4839541590138;1251.7871961766339;1439.1221354973459;1460.5983354577363;1473.8010368600317;1481.9184944828137;1509.1020842598637;8168.509889406655;8177.836443271221;8181.836363272821;8200.753977380688;8222.465539739898;1205.572021932219;1209.304649826336;1214.174361434233;1215.398377802993;1233.9444724987397;6295.433410993032;6407.359264073649;6439.839004024937;6446;6494.1557597512965;10384.532696028546;10666.146708263475;10692.09117225029;10705.89294107049;10867.673969780919;10295.176385889112;10346.689599312032;10475.84286235707;10475.84286235707;10634.20243481742;8007.399445041645;8114.513129212266;8121.8375632488205;8135.471194372347;8176.305014073751;7708.344790692629;7725.072991240862;7733.690652373842;7775.494592851446;7856.7250146244605;9263.212626926786;9408.106229908148;9439.858402124111;9562.282828788007;9593.616255349987;9548.376775947967;9595.184409325286;9635.710928672152;9655.613775448903;9791.755206119904;7228.855422891407;7265;7276.345128938421;7299.4160467163565;7455.291747284216;8235.258826705385;8351.958240209004;8375.41372103947;8377.623006964579;8380.874286885824;7609.086909570887;7849.215078492105;7943.801404964922;8057.43597948138;8245.175482451707;7657.46397752152;7657.693692252247;7679.731209407644;7726.42051846125;7800.726974555863;7308.524945878501;7499.737509187153;7528.811779705551;7565.054368203974;7747.30274275318;7128.322809333105;7208.387287080447;7219.061522002106;7220.205777364591;7233.31283528064;7112.253213412724;7140.964295178491;7240.927590724025;7267.7819665410125;7306.59813710251 19:10:39 INFO - PROCESS | 29499 | |4;prototype.html;361.60584962390993;371.10193332136237;379.07883842263305;382.6995808290489;386.8781333879826;6331.303556608775;6333.493320534346;6334.936650633498;6344.682765861711;6537.607743535391;6274.56078074535;6324.956382196932;6364.045393191012;6364.268109167447;6368.681565921697;4867.196912509432;4881.023795240957;4891.657583969123;4892.266160075981;4895.706257624536;4857.878553036185;4890.755462226893;4897.877553061184;4905.754712264373;4914.631402644798;4536.251518499444;4658.90682186356;4678.625709943213;4763.261694437368;4773.379460670108;4734.289856521515;4751.95248047522;4759.619230461572;4768;4773.212419950704;4215.915681686349;4223.831046758126;4224.957750422487;4236.216299984482;4252.659787217015;5992.760289588411;6033.668148251844;6043.063325184604;6056.242969628796;6058.96970515149;5478.315210598676;5644.887102257973;5653.067243904751;5668.31980162379;5672.092465205588;6651.800445986628;6684.83287917801;6687.097241872334;6705.798826035227;6707.3292670732535;4644.790984405709;4688.765561721934;4731.29030645406;4732.313814496913;4735.100330937111;6886.449084073262;6947.513674042819;6988.895166572505;7000.159980802337;7041.295870412918;4802.831900883452;4817.686850354716;4823.589994850477;4830.178869592178;4838.298446725275;4894.070126675921;4896.265560165933;4896.46138924718;4896.632752543574;4898.069366820293;5611.803586874522;5630.07103827872;5635.098384258581;5644.943550564524;5646.57650676201;6671.833204169935;6746.22418421878;6750.35871592198;6758.628275444898;6790.456763458911;1719.4497760716451;1735.1324337831084;1741.1903464888887;1744.4592176425094;1748.1608827762745;1163.069544364505;1163.755611321632;1173.747644256489;1184.3426898071652;1191.4817054581285;6597.86804263912;6599.901001484982;6612.7354905804195;6624.701888415033;6715.56348837324;6987.5807451552055;6992.61540615271;6997.300269972962;7016.649167541603;7026.718931242795;6350.841228969312;6386.552941294065;6608.966955165193;6665.366790154928;6710.362515561014;3725.7578257413184;3791.0711875590655;3829.1193025604266;3835.558910725302;3849.8652547160714;7304.853902921912;7337.486375953738;7345.118585769635;7356.705731770669;7357.153927298322;7079.539829911039;7209.819754506179;7220.4584656151;7236.638168091575;7277.89083163753;7231.819204519929;7254.600996945113;7318.853622927511;7320.853582928312;7337.523061001125;7016.403605693573;7047.6828542714675;7049.506534542533;7071.540349877241;7087.149542054986;6757.45940324763;6889.414399775875;6919.8962015568795;6920.9307906920285;6925.995730619133;7311.341979221896;7329.267073292628;7330.120385553768;7330.633468326456;7332.9266707332245;4800.35195248637;4841.443234027991;4844.128056949783;4853.830115946066;4856.1016212000895;6826.692798824164;6998.16022077354;7014.333638304353;7063;7088.184858741311;6844.349786770249;6854.074699915647;6854.6229957352825;6862;6880.8967865483055;6677.632730199885;6814.93185068143;6829.2487826338065;6834.248232694499;6891.931080689329;6736.461083113241;6743.224529179207;6774.356436138559;6833.145856767904;6835.692393842389;6856.588604683735;6864.897026544706;6895.5173137879865;6910.619915904674;6927.238003819677;6536.803895883131;6688.732450702112;6736.326367363225;6743.325667433218;6758.222804377363 19:10:39 INFO - PROCESS | 29499 | |5;yui.html;823.9011318641764;846.8137009857829;948.6632245552829;955.3074021334533;974.7075877236828;13244.668883277911;13486.46054157835;13510.392032358543;13534.39095240714;13539.932300338509;13563.660908477294;13614;13625.182489050663;13670.248136352497;13710.794338084937;733.6698485681438;864.4510735682824;877.1447838357614;877.2236570635002;878.5431575580694;739.9445041621873;816.346922462031;882.3206131278912;886.1404437695425;887.1749273175943;928.1692884868039;930.2139691960283;930.6556574067605;937.4984383354906;938.760616042908;925.7361651929168;926.3422969691527;926.9443833370019;927.5408672707019;928.5635751196927;685.2462291479333;687.4363022321699;688.404530081476;689.8171984424132;690.023616582535;12169.878301217052;12242.44908979089;12278.938605307005;12281.508739650404;12287.447064882102;13809.654758631115;13839.100458470268;14019.228942408163;14220.217888016155;14234.786478202835;11242.943785281102;11334.43327833605;11359.886401135966;11464.885351146466;11668;3898.9805050974564;3932.5674175840636;3940.1528671335514;3946.7631942083567;4042.8787136385954;48531;48732.51267487315;49656.75171624119;49898.50101498975;50036;10530.36817790935;10623.150147988143;10924.344539327665;10988.945055274833;11072.335659860435;18415.53961150955;19802.70295945562;19803.801961980484;19833.60332793336;19905.60188796216;7736.92263077362;7857;7980.760577182694;8008.319292860056;8139.186081391932;3993.7603743775467;4080.2859499587453;4186.895327616834;4191.098913733562;4194.559571244975;3397.8470968806464;3430.936409712997;3444.6727560881677;3451.3960056990427;3456.498807672873;607.0711810929286;614.1494030767419;619.102301662591;624.4317670919442;629.3329071184468;535.4244187498455;546.9097598896217;580.7241560258843;627.5230824573357;647.2944490505372;8299.128591497805;8322.916770832215;8373.623186956602;8416.368772342099;8470.915290847013;545.1196317946567;562.7242651101013;569.9968056221081;642.1715986377613;656.7668477690447;3814.4659747635355;4214.3889136075095;4265.360195970629;4273.974246180895;4447.755373454426;64971.675141623986;65074.349256507776;65450;65986.67006665032;66235.33764662388;51968.74015629973;53155.468445315055;53230;53457.7327113362;53790.46209537933;46651.76674116676;47092.293615595794;47135.29297060547;48318.27522587164;49001.50998490041;8296.377771667028;8324.958375208085;8465.66137354499;8678.522681252593;8799.164079412702;34256.314873701886;35044.64955350414;35746.10634734153;36210.45684314684;37049.44425833668;45288.32067519056;45513;46142;46282.30576541422;47167;10647.89352106469;10853.891461085288;10885.401302928414;10920.453977300944;10931.344119352865;11909;11966.22219555726;12122.151449398458;12366.319852408204;12702.745945081231;11749.941250293694;11942.223755455867;11968;12177.878221218029;12217.69455763613;11098.389588572383;11315.943420283174;11410.94294528522;11411.714707132389;11492.827607585725;10727.517261723086;11117.944410277896;11204.047655949336;11222.270552414067;11309.773804523698;8867.73396798097;8936.687215947411;8954.328425367994;8964.193222609996;9060.456372617664;10024.799504010025;10048.145907597936;10217;10269.589216431557;10332.948335258276 19:10:39 INFO - PROCESS | 29499 | __end_tp_report 19:10:39 INFO - PROCESS | 29499 | __start_cc_report 19:10:39 INFO - PROCESS | 29499 | _x_x_mozilla_cycle_collect,302 19:10:39 INFO - PROCESS | 29499 | __end_cc_report 19:10:39 INFO - PROCESS | 29499 | __startTimestamp1454382639496__endTimestamp 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | ------- Summary: start ------- 19:10:39 INFO - PROCESS | 29499 | Number of tests: 6 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#0] dojo.html Cycles:165 Average:5508.54 Median:5740.74 stddev:609.43 (10.6%) stddev-sans-first:586.48 19:10:39 INFO - PROCESS | 29499 | Values: 3313.8 3374.9 3398.2 3406.5 3413.4 5469.9 5497.2 5504.4 5505.3 5525.1 5406.3 5497.8 5510.9 5516.6 5538.4 4979.6 5027.7 5089.5 5113.8 5115.6 4891.9 4989.4 5081.1 5085.1 5150.6 5024.8 5073.3 5122.6 5124.1 5130.7 5029.3 5040.6 5058.1 5072.4 5073.1 4951.8 4962.8 4976.6 4986.7 5023.8 5242.2 5287.8 5295.5 5322.5 5348.1 5894.1 5937.7 5952.3 5957.3 5967.2 5785.9 5883.0 5908.3 5931.1 6012.9 5612.4 5638.6 5647.9 5654.1 5654.3 6069.8 6086.0 6092.2 6101.5 6101.5 5773.5 5849.2 5861.3 5922.6 5956.1 5930.5 5948.1 5949.6 5959.3 5960.1 5737.7 5884.2 5915.9 5929.2 5934.0 5782.8 5884.4 5916.2 5934.3 5945.0 4466.6 4481.1 4482.3 4488.8 4503.2 4015.9 4022.0 4055.3 4065.4 4086.8 5630.9 5685.1 5685.6 5689.3 5713.3 5885.5 5892.0 5897.7 5906.2 5911.9 5582.2 5598.9 5609.8 5611.6 5694.2 5062.1 5084.3 5110.5 5111.1 5139.3 6014.5 6058.1 6080.9 6088.6 6120.2 5882.5 5903.1 5903.6 5947.3 5964.3 6142.7 6184.6 6185.5 6187.6 6205.5 5922.9 5927.4 5948.9 5959.9 5970.3 5748.4 5828.1 5832.1 5851.7 5976.5 5740.7 5792.4 5792.7 5807.4 5836.9 5765.7 5767.3 5779.0 5782.0 5800.7 5617.1 5674.1 5701.2 5717.8 5722.6 5833.8 5847.6 5905.7 5906.5 5940.3 5725.9 5741.9 5762.6 5765.3 5767.0 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#1] ext.html Cycles:180 Average:58287.44 Median:41675.27 stddev:116618.40 (279.8%) stddev-sans-first:116864.90 19:10:39 INFO - PROCESS | 29499 | Values: 524.1 561.3 566.8 570.4 635.9 29624.0 35957.0 36541.8 36568.3 36686.8 40065.4 40427.8 40618.6 40896.6 40985.6 8455.7 8651.0 8720.2 8722.7 8733.2 8529.7 8671.0 8671.0 8672.6 8942.3 8888.2 8919.7 8928.7 8935.3 8936.6 8810.0 8832.2 8851.3 8869.2 8934.6 8763.1 8891.6 8906.4 8939.4 8940.1 41575.2 41911.2 42001.2 42065.6 42164.0 3513.8 3570.4 3793.3 4083.6 4340.4 30564.4 30736.1 30864.5 30974.8 31822.7 4058.1 4103.3 4146.3 4206.2 4246.2 289027.0 290702.0 333003.0 336155.0 337097.0 58754.7 58850.4 58870.0 59493.4 59514.7 64124.0 64304.0 64427.0 64506.4 64822.0 15987.9 16102.3 16223.4 16298.1 16307.9 12751.4 12809.4 12827.1 12839.9 12845.1 21454.5 21629.4 21809.8 21858.8 21947.2 8594.8 8869.2 8887.8 8950.3 8964.7 1003.9 1035.9 1075.5 1103.9 1112.4 29875.3 30215.4 30239.4 30494.5 30522.7 1157.1 1159.2 1167.2 1260.9 1282.3 15008.6 15009.2 15093.9 15185.5 15321.8 527318.0 530581.0 537877.0 687578.0 706585.0 53257.7 54244.5 54326.0 54715.0 54715.2 1436.6 1445.8 1454.9 1456.1 1475.6 29216.4 33015.2 33242.5 33523.7 33728.8 50705.2 52106.0 52156.7 52525.5 52634.0 328444.0 329773.0 332247.0 333394.0 333796.0 44497.6 44721.0 45033.0 45137.8 46134.3 46633.3 46924.3 47398.5 47565.3 48476.0 40921.6 41672.8 41677.7 42818.8 42881.1 39819.0 41742.8 41840.6 41868.2 42115.2 42231.6 42612.6 42632.4 43046.1 43780.3 32008.2 32426.0 33172.0 34344.3 35128.5 26450.5 27181.3 27189.9 27227.6 27433.6 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#2] jquery.html Cycles:180 Average:25754.46 Median:36313.27 stddev:77165.42 (212.5%) stddev-sans-first:77358.40 19:10:39 INFO - PROCESS | 29499 | Values: 397.7 398.6 402.3 404.4 405.1 14276.9 14789.0 17043.7 17616.6 17689.3 10786.2 11144.6 14482.0 17197.6 17259.8 5043.5 5157.7 5616.5 5619.3 5627.2 5155.3 5371.1 5372.6 5400.9 5492.3 5355.2 5367.9 5625.9 6009.6 6027.0 6003.2 6091.5 6097.3 6282.3 6348.0 5417.9 5440.3 5451.5 5479.2 5496.9 15155.7 20200.2 20826.1 20854.9 20865.8 2136.9 2201.2 2252.9 2280.5 2304.2 10039.2 10336.4 12208.8 13039.7 13607.7 1877.2 1890.3 1912.6 1937.2 1969.8 51919.0 52003.2 52383.7 52660.7 52680.7 10673.4 11135.7 11150.0 11156.0 11201.9 14332.2 14469.9 14470.7 14490.6 14532.9 8171.6 8175.5 8236.2 8306.5 8338.8 7883.4 7891.8 7906.7 7970.8 7983.6 4596.5 4716.2 4825.4 4833.1 4881.9 1855.4 1931.2 1947.0 1947.8 1954.5 975.3 1043.2 1043.7 1117.4 1156.3 17508.6 17568.2 17820.6 18118.3 18361.5 982.6 1000.6 1023.1 1024.1 1075.6 10263.7 10442.0 10468.6 10470.4 10493.3 383100.0 388278.0 389189.0 573936.0 576894.0 69291.7 73887.6 73947.0 74101.0 77009.0 1107.4 1109.3 1230.8 1240.5 1274.4 10666.5 16008.6 16172.4 16223.4 16326.3 33651.3 34961.1 35957.3 36669.3 39147.0 47346.5 48798.0 49041.8 49365.5 50239.5 10430.8 10725.2 10829.7 10895.7 11091.3 3750.2 6398.5 6474.5 8676.0 9033.1 7910.9 8250.3 8262.6 8334.2 8435.5 8195.0 8360.1 8481.9 8600.9 8605.4 7473.8 8065.7 8299.6 8484.1 8513.5 10271.8 10811.7 10934.6 11000.6 11149.0 10795.9 10881.2 10914.4 10940.6 11240.7 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#3] mootools.html Cycles:180 Average:6084.57 Median:5189.70 stddev:3177.98 (61.2%) stddev-sans-first:3168.25 19:10:39 INFO - PROCESS | 29499 | Values: 1505.1 1524.4 1716.9 1816.3 1855.5 8522.7 8573.5 8698.7 8716.2 8771.3 8666.7 8708.0 8757.9 8767.5 8784.7 2432.7 2448.9 2450.9 2472.5 2473.5 2478.9 2576.6 2582.6 2598.7 2610.7 2454.4 2479.8 2491.5 2503.1 2509.1 2406.9 2436.2 2457.7 2463.9 2465.4 2450.2 2457.8 2463.3 2474.5 2486.3 8309.6 8387.8 8418.1 8419.4 8443.8 5135.9 5243.5 5244.8 5246.5 5278.8 3359.6 3393.4 3404.0 3429.4 3449.0 1045.7 1054.5 1061.8 1065.9 1102.7 11900.9 12075.9 12084.6 12090.9 12159.8 4761.6 4823.0 4823.3 4827.2 4831.4 10505.9 10522.1 10580.0 10587.6 10603.9 5274.2 5327.9 5340.8 5343.5 5354.1 4786.5 4861.8 4873.3 4881.1 4881.4 3895.3 3961.9 3988.4 3993.6 4000.8 1227.5 1239.0 1242.9 1243.5 1251.8 1439.1 1460.6 1473.8 1481.9 1509.1 8168.5 8177.8 8181.8 8200.8 8222.5 1205.6 1209.3 1214.2 1215.4 1233.9 6295.4 6407.4 6439.8 6446.0 6494.2 10384.5 10666.1 10692.1 10705.9 10867.7 10295.2 10346.7 10475.8 10475.8 10634.2 8007.4 8114.5 8121.8 8135.5 8176.3 7708.3 7725.1 7733.7 7775.5 7856.7 9263.2 9408.1 9439.9 9562.3 9593.6 9548.4 9595.2 9635.7 9655.6 9791.8 7228.9 7265.0 7276.3 7299.4 7455.3 8235.3 8352.0 8375.4 8377.6 8380.9 7609.1 7849.2 7943.8 8057.4 8245.2 7657.5 7657.7 7679.7 7726.4 7800.7 7308.5 7499.7 7528.8 7565.1 7747.3 7128.3 7208.4 7219.1 7220.2 7233.3 7112.3 7141.0 7240.9 7267.8 7306.6 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#4] prototype.html Cycles:180 Average:5681.62 Median:6461.68 stddev:1719.79 (26.6%) stddev-sans-first:1677.62 19:10:39 INFO - PROCESS | 29499 | Values: 361.6 371.1 379.1 382.7 386.9 6331.3 6333.5 6334.9 6344.7 6537.6 6274.6 6325.0 6364.0 6364.3 6368.7 4867.2 4881.0 4891.7 4892.3 4895.7 4857.9 4890.8 4897.9 4905.8 4914.6 4536.3 4658.9 4678.6 4763.3 4773.4 4734.3 4752.0 4759.6 4768.0 4773.2 4215.9 4223.8 4225.0 4236.2 4252.7 5992.8 6033.7 6043.1 6056.2 6059.0 5478.3 5644.9 5653.1 5668.3 5672.1 6651.8 6684.8 6687.1 6705.8 6707.3 4644.8 4688.8 4731.3 4732.3 4735.1 6886.4 6947.5 6988.9 7000.2 7041.3 4802.8 4817.7 4823.6 4830.2 4838.3 4894.1 4896.3 4896.5 4896.6 4898.1 5611.8 5630.1 5635.1 5644.9 5646.6 6671.8 6746.2 6750.4 6758.6 6790.5 1719.4 1735.1 1741.2 1744.5 1748.2 1163.1 1163.8 1173.7 1184.3 1191.5 6597.9 6599.9 6612.7 6624.7 6715.6 6987.6 6992.6 6997.3 7016.6 7026.7 6350.8 6386.6 6609.0 6665.4 6710.4 3725.8 3791.1 3829.1 3835.6 3849.9 7304.9 7337.5 7345.1 7356.7 7357.2 7079.5 7209.8 7220.5 7236.6 7277.9 7231.8 7254.6 7318.9 7320.9 7337.5 7016.4 7047.7 7049.5 7071.5 7087.1 6757.5 6889.4 6919.9 6920.9 6926.0 7311.3 7329.3 7330.1 7330.6 7332.9 4800.4 4841.4 4844.1 4853.8 4856.1 6826.7 6998.2 7014.3 7063.0 7088.2 6844.3 6854.1 6854.6 6862.0 6880.9 6677.6 6814.9 6829.2 6834.2 6891.9 6736.5 6743.2 6774.4 6833.1 6835.7 6856.6 6864.9 6895.5 6910.6 6927.2 6536.8 6688.7 6736.3 6743.3 6758.2 19:10:39 INFO - PROCESS | 29499 | 19:10:39 INFO - PROCESS | 29499 | [#5] yui.html Cycles:180 Average:14354.41 Median:45400.66 stddev:16937.61 (37.3%) stddev-sans-first:16954.65 19:10:39 INFO - PROCESS | 29499 | Values: 823.9 846.8 948.7 955.3 974.7 13244.7 13486.5 13510.4 13534.4 13539.9 13563.7 13614.0 13625.2 13670.2 13710.8 733.7 864.5 877.1 877.2 878.5 739.9 816.3 882.3 886.1 887.2 928.2 930.2 930.7 937.5 938.8 925.7 926.3 926.9 927.5 928.6 685.2 687.4 688.4 689.8 690.0 12169.9 12242.4 12278.9 12281.5 12287.4 13809.7 13839.1 14019.2 14220.2 14234.8 11242.9 11334.4 11359.9 11464.9 11668.0 3899.0 3932.6 3940.2 3946.8 4042.9 48531.0 48732.5 49656.8 49898.5 50036.0 10530.4 10623.2 10924.3 10988.9 11072.3 18415.5 19802.7 19803.8 19833.6 19905.6 7736.9 7857.0 7980.8 8008.3 8139.2 3993.8 4080.3 4186.9 4191.1 4194.6 3397.8 3430.9 3444.7 3451.4 3456.5 607.1 614.1 619.1 624.4 629.3 535.4 546.9 580.7 627.5 647.3 8299.1 8322.9 8373.6 8416.4 8470.9 545.1 562.7 570.0 642.2 656.8 3814.5 4214.4 4265.4 4274.0 4447.8 64971.7 65074.3 65450.0 65986.7 66235.3 51968.7 53155.5 53230.0 53457.7 53790.5 46651.8 47092.3 47135.3 48318.3 49001.5 8296.4 8325.0 8465.7 8678.5 8799.2 34256.3 35044.6 35746.1 36210.5 37049.4 45288.3 45513.0 46142.0 46282.3 47167.0 10647.9 10853.9 10885.4 10920.5 10931.3 11909.0 11966.2 12122.2 12366.3 12702.7 11749.9 11942.2 11968.0 12177.9 12217.7 11098.4 11315.9 11410.9 11411.7 11492.8 10727.5 11117.9 11204.0 11222.3 11309.8 8867.7 8936.7 8954.3 8964.2 9060.5 10024.8 10048.1 10217.0 10269.6 10332.9 19:10:39 INFO - PROCESS | 29499 | -------- Summary: end -------- 19:10:39 INFO - PROCESS | 29499 | 19:10:40 INFO - TEST-INFO | 29499: exit 0 19:10:40 INFO - TEST-OK | dromaeo_css | took 1108787ms 19:10:40 INFO - TEST-START | kraken 19:10:40 INFO - operating with platform_type : linux_ 19:10:40 INFO - Initialising browser for kraken test... 19:10:40 INFO - TEST-INFO | started process 29750 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6IL12C/profile http://localhost:60014/getInfo.html) 19:10:43 INFO - PROCESS | 29750 | 19:10:43 INFO - PROCESS | 29750 | (process:29828): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:10:44 INFO - PROCESS | 29750 | __metrics Screen width/height:1600/1200 19:10:44 INFO - PROCESS | 29750 | colorDepth:24 19:10:44 INFO - PROCESS | 29750 | Browser inner width/height: 1024/697 19:10:44 INFO - PROCESS | 29750 | __metrics 19:10:45 INFO - TEST-INFO | 29750: exit 0 19:10:45 INFO - Browser initialized. 19:10:45 INFO - Running cycle 1/1 for kraken test... 19:10:45 INFO - TEST-INFO | started process 29877 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6IL12C/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:10:46 INFO - PROCESS | 29877 | 19:10:46 INFO - PROCESS | 29877 | (process:29941): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:10:57 INFO - PROCESS | 29877 | RSS: Main: 140132352 19:10:57 INFO - PROCESS | 29877 | 19:10:59 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60014/tests/kraken/driver.html?testName=audio-beat-detection) 19:11:00 INFO - PROCESS | 29877 | RSS: Main: 143245312 19:11:00 INFO - PROCESS | 29877 | 19:11:02 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60014/tests/kraken/driver.html?testName=audio-dft) 19:11:03 INFO - PROCESS | 29877 | RSS: Main: 142761984 19:11:03 INFO - PROCESS | 29877 | 19:11:06 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60014/tests/kraken/driver.html?testName=audio-fft) 19:11:06 INFO - PROCESS | 29877 | RSS: Main: 143974400 19:11:06 INFO - PROCESS | 29877 | 19:11:08 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60014/tests/kraken/driver.html?testName=audio-oscillator) 19:11:09 INFO - PROCESS | 29877 | RSS: Main: 145231872 19:11:09 INFO - PROCESS | 29877 | 19:11:11 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:11:12 INFO - PROCESS | 29877 | RSS: Main: 143159296 19:11:12 INFO - PROCESS | 29877 | 19:11:15 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60014/tests/kraken/driver.html?testName=imaging-darkroom) 19:11:15 INFO - PROCESS | 29877 | RSS: Main: 143572992 19:11:15 INFO - PROCESS | 29877 | 19:11:19 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60014/tests/kraken/driver.html?testName=imaging-desaturate) 19:11:19 INFO - PROCESS | 29877 | RSS: Main: 145518592 19:11:19 INFO - PROCESS | 29877 | 19:11:22 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60014/tests/kraken/driver.html?testName=json-parse-financial) 19:11:23 INFO - PROCESS | 29877 | RSS: Main: 144367616 19:11:23 INFO - PROCESS | 29877 | 19:11:24 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:11:25 INFO - PROCESS | 29877 | RSS: Main: 145080320 19:11:25 INFO - PROCESS | 29877 | 19:11:27 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:11:27 INFO - PROCESS | 29877 | RSS: Main: 144957440 19:11:27 INFO - PROCESS | 29877 | 19:11:29 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:11:30 INFO - PROCESS | 29877 | RSS: Main: 144740352 19:11:30 INFO - PROCESS | 29877 | 19:11:32 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:11:33 INFO - PROCESS | 29877 | RSS: Main: 145268736 19:11:33 INFO - PROCESS | 29877 | 19:11:35 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:11:36 INFO - PROCESS | 29877 | RSS: Main: 144654336 19:11:36 INFO - PROCESS | 29877 | 19:11:37 INFO - PROCESS | 29877 | Cycle 1(1): loaded http://localhost:60014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60014/tests/kraken/driver.html?testName=ai-astar) 19:11:38 INFO - PROCESS | 29877 | RSS: Main: 145817600 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | __start_tp_report 19:11:38 INFO - PROCESS | 29877 | _x_x_mozilla_page_load 19:11:38 INFO - PROCESS | 29877 | _x_x_mozilla_page_load_details 19:11:38 INFO - PROCESS | 29877 | |i|pagename|runs| 19:11:38 INFO - PROCESS | 29877 | |0;ai-astar;110;106;111;110;112;121;109;109;108;109 19:11:38 INFO - PROCESS | 29877 | |1;audio-beat-detection;149;130;147;164;124;152;153;128;165;127 19:11:38 INFO - PROCESS | 29877 | |2;audio-dft;163;160;162;161;162;162;162;163;162;161 19:11:38 INFO - PROCESS | 29877 | |3;audio-fft;76;73;75;150;82;75;75;74;170;75 19:11:38 INFO - PROCESS | 29877 | |4;audio-oscillator;95;96;138;96;94;96;144;95;95;136 19:11:38 INFO - PROCESS | 29877 | |5;imaging-gaussian-blur;110;110;109;110;110;110;110;109;109;109 19:11:38 INFO - PROCESS | 29877 | |6;imaging-darkroom;148;147;147;147;148;147;147;148;147;147 19:11:38 INFO - PROCESS | 29877 | |7;imaging-desaturate;97;96;96;96;96;96;97;96;97;96 19:11:38 INFO - PROCESS | 29877 | |8;json-parse-financial;53;56;57;54;55;66;55;56;58;56 19:11:38 INFO - PROCESS | 29877 | |9;json-stringify-tinderbox;63;65;63;65;64;65;65;64;66;64 19:11:38 INFO - PROCESS | 29877 | |10;stanford-crypto-aes;81;81;80;81;81;82;82;82;81;81 19:11:38 INFO - PROCESS | 29877 | |11;stanford-crypto-ccm;109;113;111;126;121;110;116;111;111;121 19:11:38 INFO - PROCESS | 29877 | |12;stanford-crypto-pbkdf2;136;139;137;136;137;137;134;134;134;134 19:11:38 INFO - PROCESS | 29877 | |13;stanford-crypto-sha256-iterative;67;65;66;63;64;64;64;65;64;64 19:11:38 INFO - PROCESS | 29877 | __end_tp_report 19:11:38 INFO - PROCESS | 29877 | __start_cc_report 19:11:38 INFO - PROCESS | 29877 | _x_x_mozilla_cycle_collect,704 19:11:38 INFO - PROCESS | 29877 | __end_cc_report 19:11:38 INFO - PROCESS | 29877 | __startTimestamp1454382698096__endTimestamp 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | ------- Summary: start ------- 19:11:38 INFO - PROCESS | 29877 | Number of tests: 14 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.00 stddev:4.03 (3.7%) stddev-sans-first:4.28 19:11:38 INFO - PROCESS | 29877 | Values: 110.0 106.0 111.0 110.0 112.0 121.0 109.0 109.0 108.0 109.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:150.50 stddev:15.50 (10.3%) stddev-sans-first:16.32 19:11:38 INFO - PROCESS | 29877 | Values: 149.0 130.0 147.0 164.0 124.0 152.0 153.0 128.0 165.0 127.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 19:11:38 INFO - PROCESS | 29877 | Values: 163.0 160.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 161.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.00 stddev:35.97 (48.0%) stddev-sans-first:37.65 19:11:38 INFO - PROCESS | 29877 | Values: 76.0 73.0 75.0 150.0 82.0 75.0 75.0 74.0 170.0 75.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:21.38 (22.5%) stddev-sans-first:22.11 19:11:38 INFO - PROCESS | 29877 | Values: 95.0 96.0 138.0 96.0 94.0 96.0 144.0 95.0 95.0 136.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:11:38 INFO - PROCESS | 29877 | Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 109.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 19:11:38 INFO - PROCESS | 29877 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 147.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:11:38 INFO - PROCESS | 29877 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.60 (6.4%) stddev-sans-first:3.57 19:11:38 INFO - PROCESS | 29877 | Values: 53.0 56.0 57.0 54.0 55.0 66.0 55.0 56.0 58.0 56.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 19:11:38 INFO - PROCESS | 29877 | Values: 63.0 65.0 63.0 65.0 64.0 65.0 65.0 64.0 66.0 64.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 19:11:38 INFO - PROCESS | 29877 | Values: 81.0 81.0 80.0 81.0 81.0 82.0 82.0 82.0 81.0 81.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#11] stanford-crypto-ccm Cycles:10 Average:114.90 Median:114.50 stddev:5.84 (5.1%) stddev-sans-first:5.79 19:11:38 INFO - PROCESS | 29877 | Values: 109.0 113.0 111.0 126.0 121.0 110.0 116.0 111.0 111.0 121.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:136.50 stddev:1.75 (1.3%) stddev-sans-first:1.86 19:11:38 INFO - PROCESS | 29877 | Values: 136.0 139.0 137.0 136.0 137.0 137.0 134.0 134.0 134.0 134.0 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - PROCESS | 29877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:0.87 19:11:38 INFO - PROCESS | 29877 | Values: 67.0 65.0 66.0 63.0 64.0 64.0 64.0 65.0 64.0 64.0 19:11:38 INFO - PROCESS | 29877 | -------- Summary: end -------- 19:11:38 INFO - PROCESS | 29877 | 19:11:38 INFO - TEST-INFO | 29877: exit 0 19:11:38 INFO - TEST-OK | kraken | took 58871ms 19:11:38 INFO - TEST-START | v8_7 19:11:38 INFO - operating with platform_type : linux_ 19:11:38 INFO - Initialising browser for v8_7 test... 19:11:38 INFO - TEST-INFO | started process 30170 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfLeLay/profile http://localhost:60014/getInfo.html) 19:11:42 INFO - PROCESS | 30170 | 19:11:42 INFO - PROCESS | 30170 | (process:30248): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:43 INFO - PROCESS | 30170 | __metrics Screen width/height:1600/1200 19:11:43 INFO - PROCESS | 30170 | colorDepth:24 19:11:43 INFO - PROCESS | 30170 | Browser inner width/height: 1024/697 19:11:43 INFO - PROCESS | 30170 | __metrics 19:11:44 INFO - TEST-INFO | 30170: exit 0 19:11:44 INFO - Browser initialized. 19:11:44 INFO - Running cycle 1/1 for v8_7 test... 19:11:44 INFO - TEST-INFO | started process 30297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfLeLay/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:45 INFO - PROCESS | 30297 | 19:11:45 INFO - PROCESS | 30297 | (process:30362): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:11:55 INFO - PROCESS | 30297 | RSS: Main: 139862016 19:11:55 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | Cycle 1(1): loaded http://localhost:60014/tests/v8_7/run.html (next: http://localhost:60014/tests/v8_7/run.html) 19:12:18 INFO - PROCESS | 30297 | RSS: Main: 143675392 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | __start_tp_report 19:12:18 INFO - PROCESS | 30297 | _x_x_mozilla_page_load 19:12:18 INFO - PROCESS | 30297 | _x_x_mozilla_page_load_details 19:12:18 INFO - PROCESS | 30297 | |i|pagename|runs| 19:12:18 INFO - PROCESS | 30297 | |0;Richards;167.16817118020728 19:12:18 INFO - PROCESS | 30297 | |1;DeltaBlue;170.2127659574468 19:12:18 INFO - PROCESS | 30297 | |2;Encrypt;278.9400278940028 19:12:18 INFO - PROCESS | 30297 | |3;Decrypt;5191.709844559586 19:12:18 INFO - PROCESS | 30297 | |4;RayTrace;949.667616334283 19:12:18 INFO - PROCESS | 30297 | |5;Earley;572.0823798627002 19:12:18 INFO - PROCESS | 30297 | |6;Boyer;11247.191011235955 19:12:18 INFO - PROCESS | 30297 | |7;RegExp;39038.46153846154 19:12:18 INFO - PROCESS | 30297 | |8;Splay;504.2735042735043 19:12:18 INFO - PROCESS | 30297 | |9;NavierStokes;4822.115384615385 19:12:18 INFO - PROCESS | 30297 | __end_tp_report 19:12:18 INFO - PROCESS | 30297 | __startTimestamp1454382738467__endTimestamp 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | ------- Summary: start ------- 19:12:18 INFO - PROCESS | 30297 | Number of tests: 10 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 167.2 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#1] DeltaBlue Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 170.2 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 278.9 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 5191.7 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 949.7 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#5] Earley Cycles:1 Average:572.08 Median:572.08 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 572.1 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#6] Boyer Cycles:1 Average:11247.19 Median:11247.19 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 11247.2 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#7] RegExp Cycles:1 Average:39038.46 Median:39038.46 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 39038.5 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#8] Splay Cycles:1 Average:504.27 Median:504.27 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 504.3 19:12:18 INFO - PROCESS | 30297 | 19:12:18 INFO - PROCESS | 30297 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 19:12:18 INFO - PROCESS | 30297 | Values: 4822.1 19:12:18 INFO - PROCESS | 30297 | -------- Summary: end -------- 19:12:18 INFO - PROCESS | 30297 | 19:12:19 INFO - TEST-INFO | 30297: exit 0 19:12:19 INFO - TEST-OK | v8_7 | took 40394ms 19:12:19 INFO - SUITE-END | took 1208s 19:12:19 INFO - Completed test suite (00:20:08) 19:12:19 INFO - Working with test: dromaeo_css 19:12:19 INFO - Generating results file: dromaeo_css 19:12:19 INFO - Working with test: kraken 19:12:19 INFO - Generating results file: kraken 19:12:19 INFO - javascript benchmark 19:12:19 INFO - Working with test: v8_7 19:12:19 INFO - Generating results file: v8_7 19:12:19 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:19 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 19:12:19 INFO - process_Request line: dromaeo_css 7342.51 graph.html#tests=[[72,52,43]] 19:12:19 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:19 INFO - process_Request line: kraken 1487.90 graph.html#tests=[[232,52,43]] 19:12:19 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:12:19 INFO - process_Request line: v8_7 21987.11 graph.html#tests=[[230,52,43]] 19:12:19 INFO - RETURN: dromaeo_css: 7342.51 19:12:19 INFO - RETURN: kraken: 1487.90 19:12:19 INFO - RETURN: v8_7: 21987.11 19:12:19 INFO - javascript benchmark 19:12:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3313.801171929684, 3374.9325013499715, 3398.184435735421, 3406.50605662179, 3413.368526822538, 5469.863253418666, 5497.230387745713, 5504.422035686251, 5505.311836020497, 5525.11598144297, 5406.297181366417, 5497.835064948058, 5510.9448905510935, 5516.558675305976, 5538.363088244843, 4979.576735977446, 5027.698338099707, 5089.51649593288, 5113.846584602468, 5115.565176959963, 4891.902161956758, 4989.351384320052, 5081.060003899291, 5085.059264036166, 5150.587952963754, 5024.819167495635, 5073.289739436464, 5122.564582010534, 5124.052050370675, 5130.743462826862, 5029.295898574221, 5040.59675225981, 5058.064258112261, 5072.442031376546, 5073.0614836255045, 4951.8266860659705, 4962.826301079481, 4976.601871850244, 4986.650934434591, 5023.8492845214705, 5242.23987521811, 5287.788488460457, 5295.523402893758, 5322.467753224685, 5348.090824559834, 5894.086416605433, 5937.732802023919, 5952.3154837193415, 5957.255343082114, 5967.19442875215, 5785.88428231433, 5883.0, 5908.261467316585, 5931.051031834929, 6012.939870601325, 5612.382637909826, 5638.577106717013, 5647.858803529944, 5654.123610840326, 5654.349749778787, 6069.757209711651, 6086.0, 6092.238470191226, 6101.450869421773, 6101.481374083252, 5773.538116950634, 5849.239598852122, 5861.267341582302, 5922.585419020627, 5956.1065840123465, 5930.495907847881, 5948.078047902582, 5949.583529153005, 5959.344472108065, 5960.1059841023325, 5737.65574065549, 5884.176215329857, 5915.911261330997, 5929.229200203946, 5934.020886553757, 5782.797602083907, 5884.411558844167, 5916.2013128228, 5934.287885453773, 5944.970275148597, 4466.553344665573, 4481.081378317437, 4482.282834746425, 4488.753118578509, 4503.234450143484, 4015.8996025099605, 4022.0, 4055.270051390719, 4065.4308396824467, 4086.7752273625238, 5630.85922851932, 5685.0619647758485, 5685.60200785941, 5689.288838895138, 5713.314402271754, 5885.499732522698, 5891.970540147272, 5897.705114744332, 5906.173135760997, 5911.881762364815, 5582.162675598693, 5598.86002849932, 5609.803656872072, 5611.551075913917, 5694.174344719992, 5062.063518249136, 5084.313617661568, 5110.514501122388, 5111.105556527667, 5139.280500729901, 6014.548908831855, 6058.1215723719815, 6080.908786368208, 6088.634681919099, 6120.204373431426, 5882.5293976480925, 5903.144044113579, 5903.557233207613, 5947.3457919627945, 5964.343922168645, 6142.7136481981925, 6184.567080304516, 6185.474234689922, 6187.597806142587, 6205.503559715302, 5922.851928701817, 5927.436893495111, 5948.851278718067, 5959.880802383841, 5970.283565972111, 5748.396418376177, 5828.0966450200285, 5832.12518122285, 5851.736671849691, 5976.491998180029, 5740.741666624928, 5792.362840087502, 5792.681402522901, 5807.419258074159, 5836.854078648068, 5765.740541675551, 5767.307923049261, 5779.0, 5782.017057100219, 5800.651960882361, 5617.101263797773, 5674.148877668383, 5701.173329867229, 5717.828465146053, 5722.599418040697, 5833.766649333979, 5847.619904706351, 5905.734241959036, 5906.497947674496, 5940.316863560746, 5725.856853578527, 5741.8564535886935, 5762.567807414377, 5765.250517432707, 5766.961946849608], "unit": "score", "name": "dojo.html", "value": 5469.308448928895}, {"lowerIsBetter": false, "replicates": [524.1482590789966, 561.3376216065042, 566.8294970885122, 570.4409678515055, 635.9491240700744, 29624.0, 35957.0, 36541.81729091354, 36568.268634627355, 36686.8165659172, 40065.399019014665, 40427.797861010724, 40618.59381406185, 40896.59103408965, 40985.59014409855, 8455.661773529051, 8650.956745216265, 8720.171583699539, 8722.738317850442, 8733.214010739031, 8529.658813647447, 8671.0, 8671.0, 8672.566371681422, 8942.284617230605, 8888.155625215626, 8919.687810926618, 8928.687495937644, 8935.329850261223, 8936.64253429862, 8810.0, 8832.160944710242, 8851.336149788727, 8869.201771840533, 8934.64261429542, 8763.12368763125, 8891.644334226688, 8906.376553641248, 8939.374243802937, 8940.061293564147, 41575.1684966302, 41911.1617767646, 42001.1599768006, 42065.579344206475, 42164.0, 3513.8067406292644, 3570.357335679577, 3793.2982398256136, 4083.5916408358926, 4340.370646256307, 30564.388712225853, 30736.077917662507, 30864.53703194454, 30974.845125774227, 31822.681773182434, 4058.147788964321, 4103.302438585448, 4146.343896186801, 4206.242876282268, 4246.214450326699, 289027.0, 290702.0, 333003.0, 336155.0, 337097.0, 58754.706226468596, 58850.411495885346, 58870.0, 59493.40506594965, 59514.70242648845, 64124.0, 64304.0, 64427.0, 64506.354936450974, 64822.0, 15987.920060399623, 16102.275397607136, 16223.432179873647, 16298.10360430164, 16307.918460407622, 12751.42618582166, 12809.359532023362, 12827.102102852898, 12839.935800321125, 12845.100842941092, 21454.46363840885, 21629.351119466442, 21809.781902181094, 21858.781412185992, 21947.231846885283, 8594.828103437896, 8869.246114080246, 8887.777805554784, 8950.328725345626, 8964.731058068268, 1003.9247056470793, 1035.9226404539195, 1075.4945175767377, 1103.9126460436464, 1112.3937454087543, 29875.253118672208, 30215.395692086036, 30239.395212095635, 30494.54258186129, 30522.69477305243, 1157.1437136518916, 1159.1644893082191, 1167.1946357013633, 1260.9495620175273, 1282.2755143343982, 15008.62478438026, 15009.249537523081, 15093.924530377497, 15185.468508602145, 15321.770173447407, 527318.0, 530581.0, 537877.0, 687578.0, 706585.0, 53257.733711331195, 54244.45755542394, 54326.0, 54715.0, 54715.17927231015, 1436.6480212347833, 1445.8337291211435, 1454.8836093112525, 1456.0826679192041, 1475.5720840956003, 29216.41567168687, 33015.17462063371, 33242.501362479095, 33523.664763352055, 33728.83135584307, 50705.239421409446, 52106.0, 52156.73921630519, 52525.47474525206, 52634.0, 328444.0, 329773.0, 332247.0, 333394.0, 333796.0, 44497.55502444934, 44721.0, 45033.0, 45137.77431112823, 46134.30798538092, 46633.30050049184, 46924.296135558674, 47398.526014739415, 47565.28652070291, 48476.0, 40921.59078409178, 41672.79163604163, 41677.74435038213, 42818.78590607027, 42881.14237715291, 39819.0, 41742.79128604338, 41840.58159418367, 41868.1626367477, 42115.1576968465, 42231.577684222764, 42612.5738742621, 42632.360514592925, 43046.139077218904, 43780.34329485124, 32008.199795005312, 32426.0, 33172.0, 34344.313113738084, 35128.47307290444, 26450.470990579695, 27181.320466988484, 27189.86405067962, 27227.59158612583, 27433.58849617297], "unit": "score", "name": "ext.html", "value": 20197.073838734497}, {"lowerIsBetter": false, "replicates": [397.6957627415028, 398.55162941690617, 402.2979900074371, 404.3671653861706, 405.11482410932115, 14276.928615356934, 14789.0, 17043.744343834853, 17616.64766704665, 17689.29242830287, 10786.244962852603, 11144.554217831277, 14482.0, 17197.570060748487, 17259.82740172598, 5043.546080852722, 5157.690538567698, 5616.52259557936, 5619.269494965649, 5627.184058311543, 5155.3040339554245, 5371.086915224421, 5372.597055220855, 5400.91898621521, 5492.286002819628, 5355.223492593572, 5367.865803354928, 5625.943740562583, 6009.639421634694, 6027.035674292114, 6003.219581454383, 6091.543134264925, 6097.2683278006925, 6282.277538083134, 6348.0, 5417.88933268679, 5440.265564148829, 5451.536619387357, 5479.1781232815, 5496.862578435531, 15155.696886062216, 20200.19199232029, 20826.062827172664, 20854.895725521426, 20865.791342086537, 2136.9252076177413, 2201.1745595401726, 2252.853564518301, 2280.5096904165684, 2304.1704986204954, 10039.24705647072, 10336.379817210991, 12208.816867746991, 13039.739205215843, 13607.727845443134, 1877.1646617255326, 1890.2911408221917, 1912.550550620617, 1937.2251099560149, 1969.7814229406372, 51919.0, 52003.219951700754, 52383.73808130973, 52660.73669631666, 52680.736596317154, 10673.412962286993, 11135.665930022113, 11150.0, 11156.0, 11201.943990280159, 14332.211728354832, 14469.92765036168, 14470.710585788225, 14490.637734056732, 14532.854671453362, 8171.63227654757, 8175.509469431853, 8236.217559331853, 8306.460080094774, 8338.832563441123, 7883.36933045355, 7891.802704932308, 7906.683732650745, 7970.840583188304, 7983.640736166886, 4596.517365676623, 4716.198246298138, 4825.396825396825, 4833.081714474239, 4881.8535443936735, 1855.4248183063294, 1931.1502938706924, 1947.0362170725582, 1947.7565304336958, 1954.5309125809704, 975.2734213011211, 1043.2436483549366, 1043.6973277749519, 1117.4301106435614, 1156.346664134761, 17508.562285942953, 17568.209430575655, 17820.643587128186, 18118.275268989357, 18361.540961475803, 982.597135174575, 1000.6147633161286, 1023.1201166996377, 1024.114141267798, 1075.5587512732975, 10263.692089237335, 10442.0, 10468.63359782404, 10470.37177769321, 10493.317934334244, 383100.0, 388278.0, 389189.0, 573936.0, 576894.0, 69291.65354173197, 73887.63056184792, 73947.0, 74101.0, 77009.0, 1107.3577325151232, 1109.3066833229232, 1230.8399908011902, 1240.4913985265998, 1274.4137696659454, 10666.46667666629, 16008.599785005468, 16172.353105876104, 16223.35106595723, 16326.346946122498, 33651.326973460884, 34961.12597185091, 35957.28085438329, 36669.26661466809, 39147.0, 47346.52653473559, 48798.0, 49041.754791225816, 49365.50634493609, 50239.49760502348, 10430.791384172122, 10725.195610329101, 10829.67510974672, 10895.727606809893, 11091.279066860629, 3750.231202603405, 6398.488120950406, 6474.478497552977, 8676.0, 9033.096690330914, 7910.920890791019, 8250.298724608476, 8262.628181731716, 8334.166583341617, 8435.493870367553, 8195.034220912177, 8360.12218717026, 8481.87277190855, 8600.870986935075, 8605.440646357967, 7473.804191329361, 8065.677372905018, 8299.585020749058, 8484.109168537214, 8513.489190648581, 10271.794564108526, 10811.675649730521, 10934.559377792408, 11000.614978476035, 11149.0, 10795.946020269848, 10881.183911206534, 10914.399708016135, 10940.617078402218, 11240.662780116609], "unit": "score", "name": "jquery.html", "value": 8496.503671311373}, {"lowerIsBetter": false, "replicates": [1505.089420900355, 1524.4435780939957, 1716.8626509879202, 1816.2916462579606, 1855.4619160443472, 8522.744317670473, 8573.485590864553, 8698.695545655903, 8716.215540601344, 8771.342149338801, 8666.696665616704, 8707.956460217705, 8757.868631970525, 8767.47395156291, 8784.736457906258, 2432.6594276801216, 2448.902043918241, 2450.9142180023705, 2472.5054989002183, 2473.480569080495, 2478.938026549342, 2576.6135079738, 2582.573875310581, 2598.701149367828, 2610.6867175938914, 2454.410941374066, 2479.838810477313, 2491.451880586268, 2503.111395454615, 2509.0591028364365, 2406.8796560171922, 2436.232586735173, 2457.6682147910074, 2463.8521688698734, 2465.408302007523, 2450.215930902112, 2457.7665121813397, 2463.285647162321, 2474.480359124586, 2486.3038349262238, 8309.626066827008, 8387.832243355098, 8418.116097809703, 8419.368547358912, 8443.788905277355, 5135.87160320995, 5243.528082472596, 5244.842654720364, 5246.475352464761, 5278.841634750964, 3359.6136444308972, 3393.355262500117, 3404.0298514923375, 3429.3998550253855, 3449.034270404291, 1045.7124290820009, 1054.541274545575, 1061.814182518064, 1065.872095348563, 1102.685734565645, 11900.940495297555, 12075.852793984644, 12084.637460876187, 12090.879091209063, 12159.756804863942, 4761.619070474354, 4822.99999999993, 4823.324734537167, 4827.179379505493, 4831.444383895827, 10505.894941050492, 10522.105621022145, 10580.0, 10587.629432969808, 10603.946980265204, 5274.235235890775, 5327.946720532745, 5340.839774806762, 5343.465653434625, 5354.063038968165, 4786.545278198635, 4861.829835955725, 4873.31773551703, 4881.121398148367, 4881.414230292387, 3895.3377925752125, 3961.900952476211, 3988.361862102108, 3993.560708322082, 4000.7999600020466, 1227.472186959616, 1239.0459346303476, 1242.8757124287679, 1243.4839541590138, 1251.7871961766339, 1439.1221354973459, 1460.5983354577363, 1473.8010368600317, 1481.9184944828137, 1509.1020842598637, 8168.509889406655, 8177.836443271221, 8181.836363272821, 8200.753977380688, 8222.465539739898, 1205.572021932219, 1209.304649826336, 1214.174361434233, 1215.398377802993, 1233.9444724987397, 6295.433410993032, 6407.359264073649, 6439.839004024937, 6446.0, 6494.1557597512965, 10384.532696028546, 10666.146708263475, 10692.09117225029, 10705.89294107049, 10867.673969780919, 10295.176385889112, 10346.689599312032, 10475.84286235707, 10475.84286235707, 10634.20243481742, 8007.399445041645, 8114.513129212266, 8121.8375632488205, 8135.471194372347, 8176.305014073751, 7708.344790692629, 7725.072991240862, 7733.690652373842, 7775.494592851446, 7856.7250146244605, 9263.212626926786, 9408.106229908148, 9439.858402124111, 9562.282828788007, 9593.616255349987, 9548.376775947967, 9595.184409325286, 9635.710928672152, 9655.613775448903, 9791.755206119904, 7228.855422891407, 7265.0, 7276.345128938421, 7299.4160467163565, 7455.291747284216, 8235.258826705385, 8351.958240209004, 8375.41372103947, 8377.623006964579, 8380.874286885824, 7609.086909570887, 7849.215078492105, 7943.801404964922, 8057.43597948138, 8245.175482451707, 7657.46397752152, 7657.693692252247, 7679.731209407644, 7726.42051846125, 7800.726974555863, 7308.524945878501, 7499.737509187153, 7528.811779705551, 7565.054368203974, 7747.30274275318, 7128.322809333105, 7208.387287080447, 7219.061522002106, 7220.205777364591, 7233.31283528064, 7112.253213412724, 7140.964295178491, 7240.927590724025, 7267.7819665410125, 7306.59813710251], "unit": "score", "name": "mootools.html", "value": 4986.639117218219}, {"lowerIsBetter": false, "replicates": [361.60584962390993, 371.10193332136237, 379.07883842263305, 382.6995808290489, 386.8781333879826, 6331.303556608775, 6333.493320534346, 6334.936650633498, 6344.682765861711, 6537.607743535391, 6274.56078074535, 6324.956382196932, 6364.045393191012, 6364.268109167447, 6368.681565921697, 4867.196912509432, 4881.023795240957, 4891.657583969123, 4892.266160075981, 4895.706257624536, 4857.878553036185, 4890.755462226893, 4897.877553061184, 4905.754712264373, 4914.631402644798, 4536.251518499444, 4658.90682186356, 4678.625709943213, 4763.261694437368, 4773.379460670108, 4734.289856521515, 4751.95248047522, 4759.619230461572, 4768.0, 4773.212419950704, 4215.915681686349, 4223.831046758126, 4224.957750422487, 4236.216299984482, 4252.659787217015, 5992.760289588411, 6033.668148251844, 6043.063325184604, 6056.242969628796, 6058.96970515149, 5478.315210598676, 5644.887102257973, 5653.067243904751, 5668.31980162379, 5672.092465205588, 6651.800445986628, 6684.83287917801, 6687.097241872334, 6705.798826035227, 6707.3292670732535, 4644.790984405709, 4688.765561721934, 4731.29030645406, 4732.313814496913, 4735.100330937111, 6886.449084073262, 6947.513674042819, 6988.895166572505, 7000.159980802337, 7041.295870412918, 4802.831900883452, 4817.686850354716, 4823.589994850477, 4830.178869592178, 4838.298446725275, 4894.070126675921, 4896.265560165933, 4896.46138924718, 4896.632752543574, 4898.069366820293, 5611.803586874522, 5630.07103827872, 5635.098384258581, 5644.943550564524, 5646.57650676201, 6671.833204169935, 6746.22418421878, 6750.35871592198, 6758.628275444898, 6790.456763458911, 1719.4497760716451, 1735.1324337831084, 1741.1903464888887, 1744.4592176425094, 1748.1608827762745, 1163.069544364505, 1163.755611321632, 1173.747644256489, 1184.3426898071652, 1191.4817054581285, 6597.86804263912, 6599.901001484982, 6612.7354905804195, 6624.701888415033, 6715.56348837324, 6987.5807451552055, 6992.61540615271, 6997.300269972962, 7016.649167541603, 7026.718931242795, 6350.841228969312, 6386.552941294065, 6608.966955165193, 6665.366790154928, 6710.362515561014, 3725.7578257413184, 3791.0711875590655, 3829.1193025604266, 3835.558910725302, 3849.8652547160714, 7304.853902921912, 7337.486375953738, 7345.118585769635, 7356.705731770669, 7357.153927298322, 7079.539829911039, 7209.819754506179, 7220.4584656151, 7236.638168091575, 7277.89083163753, 7231.819204519929, 7254.600996945113, 7318.853622927511, 7320.853582928312, 7337.523061001125, 7016.403605693573, 7047.6828542714675, 7049.506534542533, 7071.540349877241, 7087.149542054986, 6757.45940324763, 6889.414399775875, 6919.8962015568795, 6920.9307906920285, 6925.995730619133, 7311.341979221896, 7329.267073292628, 7330.120385553768, 7330.633468326456, 7332.9266707332245, 4800.35195248637, 4841.443234027991, 4844.128056949783, 4853.830115946066, 4856.1016212000895, 6826.692798824164, 6998.16022077354, 7014.333638304353, 7063.0, 7088.184858741311, 6844.349786770249, 6854.074699915647, 6854.6229957352825, 6862.0, 6880.8967865483055, 6677.632730199885, 6814.93185068143, 6829.2487826338065, 6834.248232694499, 6891.931080689329, 6736.461083113241, 6743.224529179207, 6774.356436138559, 6833.145856767904, 6835.692393842389, 6856.588604683735, 6864.897026544706, 6895.5173137879865, 6910.619915904674, 6927.238003819677, 6536.803895883131, 6688.732450702112, 6736.326367363225, 6743.325667433218, 6758.222804377363], "unit": "score", "name": "prototype.html", "value": 5130.679817617763}, {"lowerIsBetter": false, "replicates": [823.9011318641764, 846.8137009857829, 948.6632245552829, 955.3074021334533, 974.7075877236828, 13244.668883277911, 13486.46054157835, 13510.392032358543, 13534.39095240714, 13539.932300338509, 13563.660908477294, 13614.0, 13625.182489050663, 13670.248136352497, 13710.794338084937, 733.6698485681438, 864.4510735682824, 877.1447838357614, 877.2236570635002, 878.5431575580694, 739.9445041621873, 816.346922462031, 882.3206131278912, 886.1404437695425, 887.1749273175943, 928.1692884868039, 930.2139691960283, 930.6556574067605, 937.4984383354906, 938.760616042908, 925.7361651929168, 926.3422969691527, 926.9443833370019, 927.5408672707019, 928.5635751196927, 685.2462291479333, 687.4363022321699, 688.404530081476, 689.8171984424132, 690.023616582535, 12169.878301217052, 12242.44908979089, 12278.938605307005, 12281.508739650404, 12287.447064882102, 13809.654758631115, 13839.100458470268, 14019.228942408163, 14220.217888016155, 14234.786478202835, 11242.943785281102, 11334.43327833605, 11359.886401135966, 11464.885351146466, 11668.0, 3898.9805050974564, 3932.5674175840636, 3940.1528671335514, 3946.7631942083567, 4042.8787136385954, 48531.0, 48732.51267487315, 49656.75171624119, 49898.50101498975, 50036.0, 10530.36817790935, 10623.150147988143, 10924.344539327665, 10988.945055274833, 11072.335659860435, 18415.53961150955, 19802.70295945562, 19803.801961980484, 19833.60332793336, 19905.60188796216, 7736.92263077362, 7857.0, 7980.760577182694, 8008.319292860056, 8139.186081391932, 3993.7603743775467, 4080.2859499587453, 4186.895327616834, 4191.098913733562, 4194.559571244975, 3397.8470968806464, 3430.936409712997, 3444.6727560881677, 3451.3960056990427, 3456.498807672873, 607.0711810929286, 614.1494030767419, 619.102301662591, 624.4317670919442, 629.3329071184468, 535.4244187498455, 546.9097598896217, 580.7241560258843, 627.5230824573357, 647.2944490505372, 8299.128591497805, 8322.916770832215, 8373.623186956602, 8416.368772342099, 8470.915290847013, 545.1196317946567, 562.7242651101013, 569.9968056221081, 642.1715986377613, 656.7668477690447, 3814.4659747635355, 4214.3889136075095, 4265.360195970629, 4273.974246180895, 4447.755373454426, 64971.675141623986, 65074.349256507776, 65450.0, 65986.67006665032, 66235.33764662388, 51968.74015629973, 53155.468445315055, 53230.0, 53457.7327113362, 53790.46209537933, 46651.76674116676, 47092.293615595794, 47135.29297060547, 48318.27522587164, 49001.50998490041, 8296.377771667028, 8324.958375208085, 8465.66137354499, 8678.522681252593, 8799.164079412702, 34256.314873701886, 35044.64955350414, 35746.10634734153, 36210.45684314684, 37049.44425833668, 45288.32067519056, 45513.0, 46142.0, 46282.30576541422, 47167.0, 10647.89352106469, 10853.891461085288, 10885.401302928414, 10920.453977300944, 10931.344119352865, 11909.0, 11966.22219555726, 12122.151449398458, 12366.319852408204, 12702.745945081231, 11749.941250293694, 11942.223755455867, 11968.0, 12177.878221218029, 12217.69455763613, 11098.389588572383, 11315.943420283174, 11410.94294528522, 11411.714707132389, 11492.827607585725, 10727.517261723086, 11117.944410277896, 11204.047655949336, 11222.270552414067, 11309.773804523698, 8867.73396798097, 8936.687215947411, 8954.328425367994, 8964.193222609996, 9060.456372617664, 10024.799504010025, 10048.145907597936, 10217.0, 10269.589216431557, 10332.948335258276], "unit": "score", "name": "yui.html", "value": 6525.104139612195}], "name": "dromaeo_css", "value": 7342.50876429771}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 110.0, 112.0, 121.0, 109.0, 109.0, 108.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [149.0, 130.0, 147.0, 164.0, 124.0, 152.0, 153.0, 128.0, 165.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.9}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 75.0, 150.0, 82.0, 75.0, 75.0, 74.0, 170.0, 75.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 138.0, 96.0, 94.0, 96.0, 144.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [53.0, 56.0, 57.0, 54.0, 55.0, 66.0, 55.0, 56.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 80.0, 81.0, 81.0, 82.0, 82.0, 82.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [109.0, 113.0, 111.0, 126.0, 121.0, 110.0, 116.0, 111.0, 111.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.9}, {"lowerIsBetter": true, "replicates": [136.0, 139.0, 137.0, 136.0, 137.0, 137.0, 134.0, 134.0, 134.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.6}], "name": "kraken", "value": 1487.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "DeltaBlue", "value": 388.4432500000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [572.0823798627002], "unit": "score", "name": "Earley", "value": 1164.9773239999997}, {"lowerIsBetter": false, "replicates": [11247.191011235955], "unit": "score", "name": "Boyer", "value": 59.25595104895108}, {"lowerIsBetter": false, "replicates": [39038.46153846154], "unit": "score", "name": "RegExp", "value": 23.3355763546798}, {"lowerIsBetter": false, "replicates": [504.2735042735043], "unit": "score", "name": "Splay", "value": 161.60079661016943}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21987.10845614131}]} 19:12:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21987.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1487.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7342.51"}}} 19:12:19 INFO - Return code: 0 19:12:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:12:19 INFO - # TBPL SUCCESS # 19:12:19 INFO - Running post-action listener: _resource_record_post_action 19:12:19 INFO - Running post-run listener: _resource_record_post_run 19:12:21 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 266240; Write bytes: 509403136; Read time: 28; Write time: 443824 19:12:21 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 241737728; Read time: 0; Write time: 273892 19:12:21 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 266240; Write bytes: 258560000; Read time: 28; Write time: 169248 19:12:21 INFO - Running post-run listener: _upload_blobber_files 19:12:21 INFO - Blob upload gear active. 19:12:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:12:21 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:12:21 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:12:21 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:12:21 INFO - (blobuploader) - INFO - Open directory for files ... 19:12:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:12:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:12:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:22 INFO - (blobuploader) - INFO - Done attempting. 19:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:23 INFO - (blobuploader) - INFO - Done attempting. 19:12:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:23 INFO - Return code: 0 19:12:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:12:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f42d664f1bfee765783c474848c0c5a935c8a486db304d8396e551deea96e2fb72bc101bb904bf5481d4fdfdfd51f40276bcdcb6756f23d78c722dfffb0a146c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/871696f60391e0d6e5ce112c67742ad5481c3ac8dfed85367d4b8a98979239036ddaeb1c349cfa9c0388a5b03c836bfd1c1f0d4af5b37b67718af91022c92774"} 19:12:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:12:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:12:23 INFO - Contents: 19:12:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f42d664f1bfee765783c474848c0c5a935c8a486db304d8396e551deea96e2fb72bc101bb904bf5481d4fdfdfd51f40276bcdcb6756f23d78c722dfffb0a146c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/871696f60391e0d6e5ce112c67742ad5481c3ac8dfed85367d4b8a98979239036ddaeb1c349cfa9c0388a5b03c836bfd1c1f0d4af5b37b67718af91022c92774"} 19:12:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:23 INFO - Copying logs to upload dir... 19:12:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:12:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.726745 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-01 19:12:23.461750) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-01 19:12:23.465734) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 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/f42d664f1bfee765783c474848c0c5a935c8a486db304d8396e551deea96e2fb72bc101bb904bf5481d4fdfdfd51f40276bcdcb6756f23d78c722dfffb0a146c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/871696f60391e0d6e5ce112c67742ad5481c3ac8dfed85367d4b8a98979239036ddaeb1c349cfa9c0388a5b03c836bfd1c1f0d4af5b37b67718af91022c92774"} build_url:https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/O_KnzT51Ta2abIwsrSxhMQ/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/f42d664f1bfee765783c474848c0c5a935c8a486db304d8396e551deea96e2fb72bc101bb904bf5481d4fdfdfd51f40276bcdcb6756f23d78c722dfffb0a146c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/871696f60391e0d6e5ce112c67742ad5481c3ac8dfed85367d4b8a98979239036ddaeb1c349cfa9c0388a5b03c836bfd1c1f0d4af5b37b67718af91022c92774"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-01 19:12:23.491037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 19:12:23.491417) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1454377571.596007-1914569920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-01 19:12:23.577557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 19:12:23.577913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-01 19:12:23.578260) ========= ========= Total master_lag: 0.28 =========