builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1453608492.52 results: success (0) buildid: 20160123173004 builduid: d7c713120ef241e8aec2baf190cb74f9 revision: 4a9c0981668c0c1a29b8143b54ad56e323d65b72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.521511) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.522103) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.522433) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.540925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.541298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.562325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.562764) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.610687) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.611066) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.611543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.611920) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-23 20:08:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2016-01-23 20:08:12 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.786940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.787320) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051385 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.850933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:12.851355) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a9c0981668c0c1a29b8143b54ad56e323d65b72 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4a9c0981668c0c1a29b8143b54ad56e323d65b72 --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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-23 20:08:13,129 truncating revision to first 12 chars 2016-01-23 20:08:13,129 Setting DEBUG logging. 2016-01-23 20:08:13,129 attempt 1/10 2016-01-23 20:08:13,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a9c0981668c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-23 20:08:13,512 unpacking tar archive at: fx-team-4a9c0981668c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:13.539009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:13.539396) ========= echo 4a9c0981668c0c1a29b8143b54ad56e323d65b72 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4a9c0981668c0c1a29b8143b54ad56e323d65b72'] 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 4a9c0981668c0c1a29b8143b54ad56e323d65b72 program finished with exit code 0 elapsedTime=0.003350 script_repo_revision: '4a9c0981668c0c1a29b8143b54ad56e323d65b72' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:13.588667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:13.589071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-23 20:08:13.600112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-23 20:08:13.600575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:08:13 INFO - MultiFileLogger online at 20160123 20:08:13 in /builds/slave/test-pgo 20:08:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:08:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:08:13 INFO - {'append_to_log': False, 20:08:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:08:13 INFO - 'blob_upload_branch': 'Fx-Team', 20:08:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:08:13 INFO - 'branch': 'Fx-Team', 20:08:13 INFO - 'buildbot_json_path': 'buildprops.json', 20:08:13 INFO - 'config_files': ('talos/linux_config.py',), 20:08:13 INFO - 'default_actions': ('clobber', 20:08:13 INFO - 'read-buildbot-config', 20:08:13 INFO - 'download-and-extract', 20:08:13 INFO - 'populate-webroot', 20:08:13 INFO - 'create-virtualenv', 20:08:13 INFO - 'install', 20:08:13 INFO - 'run-tests'), 20:08:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:08:13 INFO - 'download_minidump_stackwalk': True, 20:08:13 INFO - 'download_symbols': 'ondemand', 20:08:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:08:13 INFO - 'tooltool.py': '/tools/tooltool.py', 20:08:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:08:13 INFO - '/tools/misc-python/virtualenv.py')}, 20:08:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:08:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:08:13 INFO - 'installer_path': 'installer.exe', 20:08:13 INFO - 'log_level': 'info', 20:08:13 INFO - 'log_name': 'talos', 20:08:13 INFO - 'log_to_console': True, 20:08:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:08:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:08:13 INFO - 'opt_config_files': (), 20:08:13 INFO - 'pip_index': False, 20:08:13 INFO - 'sps_profile': False, 20:08:13 INFO - 'sps_profile_interval': 0, 20:08:13 INFO - 'suite': 'dromaeojs-e10s', 20:08:13 INFO - 'system_bits': '32', 20:08:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:08:13 INFO - 'title': 'talos-linux64-ix-016', 20:08:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:08:13 INFO - 'use_talos_json': True, 20:08:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:08:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:08:13 INFO - 'work_dir': 'build'} 20:08:13 INFO - ##### 20:08:13 INFO - ##### Running clobber step. 20:08:13 INFO - ##### 20:08:13 INFO - Running pre-action listener: _resource_record_pre_action 20:08:13 INFO - Running main action method: clobber 20:08:13 INFO - rmtree: /builds/slave/test-pgo/build 20:08:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:08:15 INFO - Running post-action listener: _resource_record_post_action 20:08:15 INFO - ##### 20:08:15 INFO - ##### Running read-buildbot-config step. 20:08:15 INFO - ##### 20:08:15 INFO - Running pre-action listener: _resource_record_pre_action 20:08:15 INFO - Running main action method: read_buildbot_config 20:08:15 INFO - Using buildbot properties: 20:08:15 INFO - { 20:08:15 INFO - "project": "", 20:08:15 INFO - "product": "firefox", 20:08:15 INFO - "script_repo_revision": "production", 20:08:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:08:15 INFO - "repository": "", 20:08:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:08:15 INFO - "buildid": "20160123173004", 20:08:15 INFO - "pgo_build": "True", 20:08:15 INFO - "basedir": "/builds/slave/test-pgo", 20:08:15 INFO - "buildnumber": 133, 20:08:15 INFO - "slavename": "talos-linux64-ix-016", 20:08:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:08:15 INFO - "platform": "ubuntu64_hw", 20:08:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:08:15 INFO - "branch": "fx-team", 20:08:15 INFO - "repo_path": "integration/fx-team", 20:08:15 INFO - "revision": "4a9c0981668c0c1a29b8143b54ad56e323d65b72", 20:08:15 INFO - "stage_platform": "linux64-pgo", 20:08:15 INFO - "builduid": "d7c713120ef241e8aec2baf190cb74f9", 20:08:15 INFO - "slavebuilddir": "test" 20:08:15 INFO - } 20:08:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:08:15 INFO - Running post-action listener: _resource_record_post_action 20:08:15 INFO - ##### 20:08:15 INFO - ##### Running download-and-extract step. 20:08:15 INFO - ##### 20:08:15 INFO - Running pre-action listener: _resource_record_pre_action 20:08:15 INFO - Running main action method: download_and_extract 20:08:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:15 INFO - https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/test_packages.json 20:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/test_packages.json 20:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:08:15 INFO - Downloaded 1448 bytes. 20:08:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:08:15 INFO - Using the following test package requirements: 20:08:15 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:15 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:08:15 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:08:15 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'jsshell-linux-x86_64.zip'], 20:08:15 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:08:15 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:15 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:08:15 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:08:15 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:08:15 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:08:15 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:08:15 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:08:15 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:15 INFO - https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:17 INFO - Downloaded 22488796 bytes. 20:08:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:08:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:08:18 INFO - Return code: 0 20:08:18 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:08:18 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')]} 20:08:18 INFO - https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:08:20 INFO - Downloaded 22488796 bytes. 20:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:08:21 INFO - Return code: 0 20:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:21 INFO - https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:08:22 INFO - Downloaded 10706572 bytes. 20:08:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:08:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:08:22 INFO - Return code: 0 20:08: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')]} 20:08:22 INFO - https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:08:24 INFO - Downloaded 55955056 bytes. 20:08:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:08:24 INFO - mkdir: /builds/slave/test-pgo/properties 20:08:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:08:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:08:24 INFO - Contents: 20:08:24 INFO - build_url:https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:08:24 INFO - Running post-action listener: _resource_record_post_action 20:08:24 INFO - Running post-action listener: set_extra_try_arguments 20:08:24 INFO - ##### 20:08:24 INFO - ##### Running populate-webroot step. 20:08:24 INFO - ##### 20:08:24 INFO - Running pre-action listener: _resource_record_pre_action 20:08:24 INFO - Running main action method: populate_webroot 20:08:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:08:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:08:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:08:24 INFO - '--tppagecycles', 20:08:24 INFO - '7'], 20:08:24 INFO - 'tests': ['tsvgm']}}, 20:08:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:08:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:08:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:08:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:08:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:08:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'tests': ['damp', 'tps']}, 20:08:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['damp', 'tps']}, 20:08:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:08:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:08:24 INFO - 'other': {'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'other_l64': {'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'other_nol64': {'tests': ['a11yr', 20:08:24 INFO - 'ts_paint', 20:08:24 INFO - 'tpaint', 20:08:24 INFO - 'sessionrestore', 20:08:24 INFO - 'sessionrestore_no_auto_restore']}, 20:08:24 INFO - 'svgr': {'tests': ['tsvgx', 20:08:24 INFO - 'tsvgr_opacity', 20:08:24 INFO - 'tart', 20:08:24 INFO - 'tscrollx', 20:08:24 INFO - 'cart']}, 20:08:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['tsvgx', 20:08:24 INFO - 'tsvgr_opacity', 20:08:24 INFO - 'tart', 20:08:24 INFO - 'tscrollx', 20:08:24 INFO - 'cart']}, 20:08:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'tests': ['tp5o']}, 20:08:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'talos_options': ['--e10s'], 20:08:24 INFO - 'tests': ['tp5o']}, 20:08:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'talos_options': ['--xperf_path', 20:08:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:24 INFO - 'tests': ['tp5n']}, 20:08:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:08:24 INFO - 'talos_options': ['--e10s', 20:08:24 INFO - '--xperf_path', 20:08:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:08:24 INFO - 'tests': ['tp5n']}}, 20:08:24 INFO - 'talos.zip': {'path': '', 20:08:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:08:24 INFO - Running post-action listener: _resource_record_post_action 20:08:24 INFO - ##### 20:08:24 INFO - ##### Running create-virtualenv step. 20:08:24 INFO - ##### 20:08:24 INFO - Running pre-action listener: _resource_record_pre_action 20:08:24 INFO - Running main action method: create_virtualenv 20:08:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:08:24 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 20:08:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:08:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:08:24 INFO - Using real prefix '/usr' 20:08:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 20:08:26 INFO - Installing pip.................done. 20:08:26 INFO - Return code: 0 20:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:08:26 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')]} 20:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:26 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')]} 20:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:26 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:26 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 20:08:26 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 20:08:26 INFO - Using env: {'DISPLAY': ':0', 20:08:26 INFO - 'HOME': '/home/cltbld', 20:08:26 INFO - 'LANG': 'en_US.UTF-8', 20:08:26 INFO - 'LANGUAGE': 'en_US:en', 20:08:26 INFO - 'LOGNAME': 'cltbld', 20:08:26 INFO - 'MAIL': '/var/mail/cltbld', 20:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:26 INFO - 'MOZ_NO_REMOTE': '1', 20:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:26 INFO - 'NO_EM_RESTART': '1', 20:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:26 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:26 INFO - 'SHELL': '/bin/bash', 20:08:26 INFO - 'SHLVL': '1', 20:08:26 INFO - 'TERM': 'linux', 20:08:26 INFO - 'TMOUT': '86400', 20:08:26 INFO - 'USER': 'cltbld', 20:08:26 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:26 INFO - '_': '/tools/buildbot/bin/python'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 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 20:08:27 INFO - Cleaning up... 20:08:27 INFO - Return code: 0 20:08:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:08:27 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')]} 20:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 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')]} 20:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:27 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:27 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 20:08:27 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 20:08:27 INFO - Using env: {'DISPLAY': ':0', 20:08:27 INFO - 'HOME': '/home/cltbld', 20:08:27 INFO - 'LANG': 'en_US.UTF-8', 20:08:27 INFO - 'LANGUAGE': 'en_US:en', 20:08:27 INFO - 'LOGNAME': 'cltbld', 20:08:27 INFO - 'MAIL': '/var/mail/cltbld', 20:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:27 INFO - 'MOZ_NO_REMOTE': '1', 20:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:27 INFO - 'NO_EM_RESTART': '1', 20:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:27 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:27 INFO - 'SHELL': '/bin/bash', 20:08:27 INFO - 'SHLVL': '1', 20:08:27 INFO - 'TERM': 'linux', 20:08:27 INFO - 'TMOUT': '86400', 20:08:27 INFO - 'USER': 'cltbld', 20:08:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:27 INFO - '_': '/tools/buildbot/bin/python'} 20:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:27 INFO - Downloading/unpacking psutil>=0.7.1 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:27 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 20:08:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:29 INFO - Installing collected packages: psutil 20:08:29 INFO - Running setup.py install for psutil 20:08:29 INFO - building 'psutil._psutil_linux' extension 20:08:29 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 20:08:29 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 20:08:29 INFO - building 'psutil._psutil_posix' extension 20:08:29 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 20:08:29 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 20:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:08:29 INFO - Successfully installed psutil 20:08:29 INFO - Cleaning up... 20:08:29 INFO - Return code: 0 20:08:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:08: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')]} 20:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:29 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:29 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 20:08:29 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 20:08:29 INFO - Using env: {'DISPLAY': ':0', 20:08:29 INFO - 'HOME': '/home/cltbld', 20:08:29 INFO - 'LANG': 'en_US.UTF-8', 20:08:29 INFO - 'LANGUAGE': 'en_US:en', 20:08:29 INFO - 'LOGNAME': 'cltbld', 20:08:29 INFO - 'MAIL': '/var/mail/cltbld', 20:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:29 INFO - 'MOZ_NO_REMOTE': '1', 20:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:29 INFO - 'NO_EM_RESTART': '1', 20:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:29 INFO - 'SHELL': '/bin/bash', 20:08:29 INFO - 'SHLVL': '1', 20:08:29 INFO - 'TERM': 'linux', 20:08:29 INFO - 'TMOUT': '86400', 20:08:29 INFO - 'USER': 'cltbld', 20:08:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:29 INFO - '_': '/tools/buildbot/bin/python'} 20:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:29 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 20:08:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:08:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:08:31 INFO - Installing collected packages: mozsystemmonitor 20:08:31 INFO - Running setup.py install for mozsystemmonitor 20:08:31 INFO - Successfully installed mozsystemmonitor 20:08:31 INFO - Cleaning up... 20:08:31 INFO - Return code: 0 20:08:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:08:31 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')]} 20:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 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')]} 20:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:31 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:31 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 20:08:31 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 20:08:31 INFO - Using env: {'DISPLAY': ':0', 20:08:31 INFO - 'HOME': '/home/cltbld', 20:08:31 INFO - 'LANG': 'en_US.UTF-8', 20:08:31 INFO - 'LANGUAGE': 'en_US:en', 20:08:31 INFO - 'LOGNAME': 'cltbld', 20:08:31 INFO - 'MAIL': '/var/mail/cltbld', 20:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:31 INFO - 'MOZ_NO_REMOTE': '1', 20:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:31 INFO - 'NO_EM_RESTART': '1', 20:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:31 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:31 INFO - 'SHELL': '/bin/bash', 20:08:31 INFO - 'SHLVL': '1', 20:08:31 INFO - 'TERM': 'linux', 20:08:31 INFO - 'TMOUT': '86400', 20:08:31 INFO - 'USER': 'cltbld', 20:08:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:31 INFO - '_': '/tools/buildbot/bin/python'} 20:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:32 INFO - Downloading/unpacking blobuploader==1.2.4 20:08:32 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 20:08:32 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 20:08:32 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 20:08:32 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 20:08:32 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 20:08:32 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 20:08:33 INFO - Downloading blobuploader-1.2.4.tar.gz 20:08:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:08:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:08:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:34 INFO - Downloading docopt-0.6.1.tar.gz 20:08:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:08:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:08:34 INFO - Running setup.py install for blobuploader 20:08:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:08:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:08:34 INFO - Running setup.py install for requests 20:08:35 INFO - Running setup.py install for docopt 20:08:35 INFO - Successfully installed blobuploader requests docopt 20:08:35 INFO - Cleaning up... 20:08:35 INFO - Return code: 0 20:08:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:08:35 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')]} 20:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:35 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')]} 20:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:35 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:35 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 20:08:35 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 20:08:35 INFO - Using env: {'DISPLAY': ':0', 20:08:35 INFO - 'HOME': '/home/cltbld', 20:08:35 INFO - 'LANG': 'en_US.UTF-8', 20:08:35 INFO - 'LANGUAGE': 'en_US:en', 20:08:35 INFO - 'LOGNAME': 'cltbld', 20:08:35 INFO - 'MAIL': '/var/mail/cltbld', 20:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:35 INFO - 'MOZ_NO_REMOTE': '1', 20:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:35 INFO - 'NO_EM_RESTART': '1', 20:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:35 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:35 INFO - 'SHELL': '/bin/bash', 20:08:35 INFO - 'SHLVL': '1', 20:08:35 INFO - 'TERM': 'linux', 20:08:35 INFO - 'TMOUT': '86400', 20:08:35 INFO - 'USER': 'cltbld', 20:08:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:35 INFO - '_': '/tools/buildbot/bin/python'} 20:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:08:35 INFO - Running setup.py (path:/tmp/pip-qPW0Ll-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:08:35 INFO - Running setup.py (path:/tmp/pip-IeqJeT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:08:35 INFO - Running setup.py (path:/tmp/pip-P7Pb2D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:08:35 INFO - Running setup.py (path:/tmp/pip-5t5j2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:08:35 INFO - Running setup.py (path:/tmp/pip-ljhdbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:08:35 INFO - Running setup.py (path:/tmp/pip-X5T21B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:08:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:08:35 INFO - Running setup.py (path:/tmp/pip-VD2moS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:08:36 INFO - Running setup.py (path:/tmp/pip-Es69X1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:08:36 INFO - Running setup.py (path:/tmp/pip-XwtRaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:08:36 INFO - Running setup.py (path:/tmp/pip-hpp0lR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:08:36 INFO - Running setup.py (path:/tmp/pip-K5YVMV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:08:36 INFO - Running setup.py (path:/tmp/pip-rGh0wF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:08:36 INFO - Running setup.py (path:/tmp/pip-9Qaet6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:08:36 INFO - Running setup.py (path:/tmp/pip-WFx20u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:08:36 INFO - Running setup.py (path:/tmp/pip-rfBPXw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:08:36 INFO - Running setup.py (path:/tmp/pip-Bn_mzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:08:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:08:36 INFO - Running setup.py (path:/tmp/pip-1r65_q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:08:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:08:36 INFO - Running setup.py install for manifestparser 20:08:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:08:36 INFO - Running setup.py install for mozcrash 20:08:36 INFO - Running setup.py install for mozdebug 20:08:37 INFO - Running setup.py install for mozdevice 20:08:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for mozfile 20:08:37 INFO - Running setup.py install for mozhttpd 20:08:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for mozinfo 20:08:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for mozInstall 20:08:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for mozleak 20:08:37 INFO - Running setup.py install for mozlog 20:08:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for moznetwork 20:08:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:08:37 INFO - Running setup.py install for mozprocess 20:08:38 INFO - Running setup.py install for mozprofile 20:08:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:08:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:08:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:08:38 INFO - Running setup.py install for mozrunner 20:08:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:08:38 INFO - Running setup.py install for mozscreenshot 20:08:38 INFO - Running setup.py install for moztest 20:08:38 INFO - Running setup.py install for mozversion 20:08:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:08:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:08:38 INFO - Cleaning up... 20:08:38 INFO - Return code: 0 20:08:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:08: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')]} 20:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:38 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:38 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 20:08:38 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 20:08:38 INFO - Using env: {'DISPLAY': ':0', 20:08:38 INFO - 'HOME': '/home/cltbld', 20:08:38 INFO - 'LANG': 'en_US.UTF-8', 20:08:38 INFO - 'LANGUAGE': 'en_US:en', 20:08:38 INFO - 'LOGNAME': 'cltbld', 20:08:38 INFO - 'MAIL': '/var/mail/cltbld', 20:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:38 INFO - 'MOZ_NO_REMOTE': '1', 20:08:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:38 INFO - 'NO_EM_RESTART': '1', 20:08:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:38 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:38 INFO - 'SHELL': '/bin/bash', 20:08:38 INFO - 'SHLVL': '1', 20:08:38 INFO - 'TERM': 'linux', 20:08:38 INFO - 'TMOUT': '86400', 20:08:38 INFO - 'USER': 'cltbld', 20:08:38 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:38 INFO - '_': '/tools/buildbot/bin/python'} 20:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:08:38 INFO - Running setup.py (path:/tmp/pip-BDQIag-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:08:38 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)) 20:08:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:08:38 INFO - Running setup.py (path:/tmp/pip-Deqotn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:08:38 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)) 20:08:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:08:38 INFO - Running setup.py (path:/tmp/pip-KqlxXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:08:38 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)) 20:08:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:08:38 INFO - Running setup.py (path:/tmp/pip-iswl0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:08:39 INFO - Running setup.py (path:/tmp/pip-hwaxs_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:08:39 INFO - Running setup.py (path:/tmp/pip-v3xfvE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:08:39 INFO - Running setup.py (path:/tmp/pip-Ba9I7t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:08:39 INFO - Running setup.py (path:/tmp/pip-0PFAwF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:08:39 INFO - Running setup.py (path:/tmp/pip-WtBgZE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:08:39 INFO - Running setup.py (path:/tmp/pip-uTvE5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:08:39 INFO - Running setup.py (path:/tmp/pip-TiLPl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:08:39 INFO - Running setup.py (path:/tmp/pip-ddj3XB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:08:39 INFO - Running setup.py (path:/tmp/pip-ZOEn7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:08:39 INFO - Running setup.py (path:/tmp/pip-RyeN9P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:08:39 INFO - Running setup.py (path:/tmp/pip-tzUFiI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:08:39 INFO - Running setup.py (path:/tmp/pip-LiURw8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:08:39 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)) 20:08:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:08:39 INFO - Running setup.py (path:/tmp/pip-SlJmUX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:08:39 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)) 20:08:39 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)) 20:08:39 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)) 20:08:39 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)) 20:08:39 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)) 20:08:39 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)) 20:08:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:41 INFO - Downloading blessings-1.6.tar.gz 20:08:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:08:41 INFO - Installing collected packages: blessings 20:08:41 INFO - Running setup.py install for blessings 20:08:41 INFO - Successfully installed blessings 20:08:41 INFO - Cleaning up... 20:08:41 INFO - Return code: 0 20:08:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:08:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:08:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:08:42 INFO - Reading from file tmpfile_stdout 20:08:42 INFO - Current package versions: 20:08:42 INFO - argparse == 1.2.1 20:08:42 INFO - blessings == 1.6 20:08:42 INFO - blobuploader == 1.2.4 20:08:42 INFO - docopt == 0.6.1 20:08:42 INFO - manifestparser == 1.1 20:08:42 INFO - mozInstall == 1.12 20:08:42 INFO - mozcrash == 0.16 20:08:42 INFO - mozdebug == 0.1 20:08:42 INFO - mozdevice == 0.48 20:08:42 INFO - mozfile == 1.2 20:08:42 INFO - mozhttpd == 0.7 20:08:42 INFO - mozinfo == 0.9 20:08:42 INFO - mozleak == 0.1 20:08:42 INFO - mozlog == 3.1 20:08:42 INFO - moznetwork == 0.27 20:08:42 INFO - mozprocess == 0.22 20:08:42 INFO - mozprofile == 0.28 20:08:42 INFO - mozrunner == 6.11 20:08:42 INFO - mozscreenshot == 0.1 20:08:42 INFO - mozsystemmonitor == 0.0 20:08:42 INFO - moztest == 0.7 20:08:42 INFO - mozversion == 1.4 20:08:42 INFO - psutil == 3.1.1 20:08:42 INFO - requests == 1.2.3 20:08:42 INFO - wsgiref == 0.1.2 20:08:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:08: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')]} 20:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:42 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:42 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 20:08:42 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 20:08:42 INFO - Using env: {'DISPLAY': ':0', 20:08:42 INFO - 'HOME': '/home/cltbld', 20:08:42 INFO - 'LANG': 'en_US.UTF-8', 20:08:42 INFO - 'LANGUAGE': 'en_US:en', 20:08:42 INFO - 'LOGNAME': 'cltbld', 20:08:42 INFO - 'MAIL': '/var/mail/cltbld', 20:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:42 INFO - 'MOZ_NO_REMOTE': '1', 20:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:42 INFO - 'NO_EM_RESTART': '1', 20:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:42 INFO - 'SHELL': '/bin/bash', 20:08:42 INFO - 'SHLVL': '1', 20:08:42 INFO - 'TERM': 'linux', 20:08:42 INFO - 'TMOUT': '86400', 20:08:42 INFO - 'USER': 'cltbld', 20:08:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:42 INFO - '_': '/tools/buildbot/bin/python'} 20:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 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)) 20:08:42 INFO - Cleaning up... 20:08:42 INFO - Return code: 0 20:08:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:08: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')]} 20:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08: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')]} 20:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:42 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:42 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 20:08:42 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 20:08:42 INFO - Using env: {'DISPLAY': ':0', 20:08:42 INFO - 'HOME': '/home/cltbld', 20:08:42 INFO - 'LANG': 'en_US.UTF-8', 20:08:42 INFO - 'LANGUAGE': 'en_US:en', 20:08:42 INFO - 'LOGNAME': 'cltbld', 20:08:42 INFO - 'MAIL': '/var/mail/cltbld', 20:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:42 INFO - 'MOZ_NO_REMOTE': '1', 20:08:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:42 INFO - 'NO_EM_RESTART': '1', 20:08:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:42 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:42 INFO - 'SHELL': '/bin/bash', 20:08:42 INFO - 'SHLVL': '1', 20:08:42 INFO - 'TERM': 'linux', 20:08:42 INFO - 'TMOUT': '86400', 20:08:42 INFO - 'USER': 'cltbld', 20:08:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:42 INFO - '_': '/tools/buildbot/bin/python'} 20:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:42 INFO - Downloading/unpacking jsonschema 20:08:42 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 20:08:42 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 20:08:42 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 20:08:42 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 20:08:42 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 20:08:42 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 20:08:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:08:44 INFO - Downloading/unpacking functools32 (from jsonschema) 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:08:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:08:44 INFO - warning: no files found matching '*.txt' 20:08:44 INFO - no previously-included directories found matching 'build' 20:08:44 INFO - no previously-included directories found matching 'dist' 20:08:44 INFO - no previously-included directories found matching '.git*' 20:08:44 INFO - Installing collected packages: jsonschema, functools32 20:08:44 INFO - Running setup.py install for functools32 20:08:44 INFO - warning: no files found matching '*.txt' 20:08:44 INFO - no previously-included directories found matching 'build' 20:08:44 INFO - no previously-included directories found matching 'dist' 20:08:44 INFO - no previously-included directories found matching '.git*' 20:08:44 INFO - Successfully installed jsonschema functools32 20:08:44 INFO - Cleaning up... 20:08:44 INFO - Return code: 0 20:08:44 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:08:44 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 0x7f876fb06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1833630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, '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': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', '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 20:08:44 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 20:08:44 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 20:08:44 INFO - Using env: {'DISPLAY': ':0', 20:08:44 INFO - 'HOME': '/home/cltbld', 20:08:44 INFO - 'LANG': 'en_US.UTF-8', 20:08:44 INFO - 'LANGUAGE': 'en_US:en', 20:08:44 INFO - 'LOGNAME': 'cltbld', 20:08:44 INFO - 'MAIL': '/var/mail/cltbld', 20:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:08:44 INFO - 'MOZ_NO_REMOTE': '1', 20:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:08:44 INFO - 'NO_EM_RESTART': '1', 20:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:08:44 INFO - 'PWD': '/builds/slave/test-pgo', 20:08:44 INFO - 'SHELL': '/bin/bash', 20:08:44 INFO - 'SHLVL': '1', 20:08:44 INFO - 'TERM': 'linux', 20:08:44 INFO - 'TMOUT': '86400', 20:08:44 INFO - 'USER': 'cltbld', 20:08:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:08:44 INFO - '_': '/tools/buildbot/bin/python'} 20:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:08:45 INFO - Downloading/unpacking flake8 20:08:45 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 20:08:45 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 20:08:45 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 20:08:45 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 20:08:45 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 20:08:45 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 20:08:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:08:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08: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 20:08:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:08:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:08:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:08:47 INFO - no previously-included directories found matching 'docs/_build' 20:08:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:08:47 INFO - Running setup.py install for pep8 20:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:08:47 INFO - no previously-included directories found matching 'docs/_build' 20:08:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:08:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:08:47 INFO - Cleaning up... 20:08:47 INFO - Return code: 0 20:08:47 INFO - Running post-action listener: _resource_record_post_action 20:08:47 INFO - Running post-action listener: _start_resource_monitoring 20:08:47 INFO - Starting resource monitoring. 20:08:47 INFO - ##### 20:08:47 INFO - ##### Running install step. 20:08:47 INFO - ##### 20:08:47 INFO - Running pre-action listener: _resource_record_pre_action 20:08:47 INFO - Running main action method: install 20:08:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:08:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:08:47 INFO - Reading from file tmpfile_stdout 20:08:47 INFO - Detecting whether we're running mozinstall >=1.0... 20:08:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:08:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:08:48 INFO - Reading from file tmpfile_stdout 20:08:48 INFO - Output received: 20:08:48 INFO - Usage: mozinstall [options] installer 20:08:48 INFO - Options: 20:08:48 INFO - -h, --help show this help message and exit 20:08:48 INFO - -d DEST, --destination=DEST 20:08:48 INFO - Directory to install application into. [default: 20:08:48 INFO - "/builds/slave/test-pgo"] 20:08:48 INFO - --app=APP Application being installed. [default: firefox] 20:08:48 INFO - mkdir: /builds/slave/test-pgo/build/application 20:08:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:08:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:09:04 INFO - Reading from file tmpfile_stdout 20:09:04 INFO - Output received: 20:09:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:09:04 INFO - Running post-action listener: _resource_record_post_action 20:09:04 INFO - ##### 20:09:04 INFO - ##### Running run-tests step. 20:09:04 INFO - ##### 20:09:04 INFO - Running pre-action listener: _resource_record_pre_action 20:09:04 INFO - Running main action method: run_tests 20:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:09:04 INFO - Python 2.7.3 20:09:04 INFO - Return code: 0 20:09:04 INFO - grabbing minidump binary from tooltool 20:09:04 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')]} 20:09:04 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 0x18c4840>, '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 0x18316b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1831b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:09:04 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 20:09:04 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 20:09:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:09:04 INFO - Return code: 0 20:09:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:09:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:09:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:09:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:09:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:09:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:09:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:09:05 INFO - Return code: 0 20:09:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:09:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 20:09:05 INFO - Using env: {'DISPLAY': ':0', 20:09:05 INFO - 'HOME': '/home/cltbld', 20:09:05 INFO - 'LANG': 'en_US.UTF-8', 20:09:05 INFO - 'LANGUAGE': 'en_US:en', 20:09:05 INFO - 'LOGNAME': 'cltbld', 20:09:05 INFO - 'MAIL': '/var/mail/cltbld', 20:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:05 INFO - 'MOZ_NO_REMOTE': '1', 20:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:09:05 INFO - 'NO_EM_RESTART': '1', 20:09:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:09:05 INFO - 'PWD': '/builds/slave/test-pgo', 20:09:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:09:05 INFO - 'SHELL': '/bin/bash', 20:09:05 INFO - 'SHLVL': '1', 20:09:05 INFO - 'TERM': 'linux', 20:09:05 INFO - 'TMOUT': '86400', 20:09:05 INFO - 'USER': 'cltbld', 20:09:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401', 20:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:05 INFO - '_': '/tools/buildbot/bin/python'} 20:09:05 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 20:09:05 INFO - mozversion application_buildid: 20160123173004 20:09:05 INFO - mozversion application_changeset: 4a9c0981668c0c1a29b8143b54ad56e323d65b72 20:09:05 INFO - mozversion application_display_name: Nightly 20:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:09:05 INFO - mozversion application_name: Firefox 20:09:05 INFO - mozversion application_remotingname: firefox 20:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:09:05 INFO - mozversion application_vendor: Mozilla 20:09:05 INFO - mozversion application_version: 46.0a1 20:09:05 INFO - mozversion platform_buildid: 20160123173004 20:09:05 INFO - mozversion platform_changeset: 4a9c0981668c0c1a29b8143b54ad56e323d65b72 20:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:09:05 INFO - mozversion platform_version: 46.0a1 20:09:05 INFO - using testdate: 1453608545 20:09:05 INFO - actual date: 1453608545 20:09:05 INFO - starting webserver on 'localhost:34489' 20:09:05 INFO - SUITE-START | Running 3 tests 20:09:05 INFO - TEST-START | dromaeo_css 20:09:05 INFO - operating with platform_type : linux_ 20:09:05 INFO - Initialising browser for dromaeo_css test... 20:09:05 INFO - TEST-INFO | started process 27054 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTixsIV/profile http://localhost:34489/getInfo.html) 20:09:09 INFO - PROCESS | 27054 | 20:09:09 INFO - PROCESS | 27054 | (process:27139): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:09 INFO - PROCESS | 27054 | __metrics Screen width/height:1600/1200 20:09:09 INFO - PROCESS | 27054 | colorDepth:24 20:09:09 INFO - PROCESS | 27054 | Browser inner width/height: 1024/697 20:09:09 INFO - PROCESS | 27054 | __metrics 20:09:10 INFO - PROCESS | 27054 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:09:10 INFO - PROCESS | 27054 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:09:10 INFO - TEST-INFO | 27054: exit 0 20:09:10 INFO - Browser initialized. 20:09:10 INFO - Running cycle 1/1 for dromaeo_css test... 20:09:10 INFO - TEST-INFO | started process 27188 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTixsIV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:12 INFO - PROCESS | 27188 | 20:09:12 INFO - PROCESS | 27188 | (process:27245): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:09:22 INFO - PROCESS | 27188 | RSS: Main: 151552000 20:09:22 INFO - PROCESS | 27188 | 20:10:12 INFO - PROCESS | 27188 | 1453608612308 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] 20:12:21 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34489/tests/dromaeo/cssquery-ext.html) 20:12:22 INFO - PROCESS | 27188 | RSS: Main: 160022528 20:12:22 INFO - PROCESS | 27188 | 20:15:24 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-ext.html (next: http://localhost:34489/tests/dromaeo/cssquery-jquery.html) 20:15:24 INFO - PROCESS | 27188 | RSS: Main: 156073984 20:15:24 INFO - PROCESS | 27188 | 20:18:26 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34489/tests/dromaeo/cssquery-mootools.html) 20:18:27 INFO - PROCESS | 27188 | RSS: Main: 155791360 20:18:27 INFO - PROCESS | 27188 | 20:21:28 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34489/tests/dromaeo/cssquery-prototype.html) 20:21:29 INFO - PROCESS | 27188 | RSS: Main: 154226688 20:21:29 INFO - PROCESS | 27188 | 20:24:31 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34489/tests/dromaeo/cssquery-yui.html) 20:24:32 INFO - PROCESS | 27188 | RSS: Main: 154525696 20:24:32 INFO - PROCESS | 27188 | 20:27:34 INFO - PROCESS | 27188 | Cycle 1(1): loaded http://localhost:34489/tests/dromaeo/cssquery-yui.html (next: http://localhost:34489/tests/dromaeo/cssquery-dojo.html) 20:27:35 INFO - PROCESS | 27188 | RSS: Main: 157958144 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | __start_tp_report 20:27:35 INFO - PROCESS | 27188 | _x_x_mozilla_page_load 20:27:35 INFO - PROCESS | 27188 | _x_x_mozilla_page_load_details 20:27:35 INFO - PROCESS | 27188 | |i|pagename|runs| 20:27:35 INFO - PROCESS | 27188 | |0;dojo.html;3183.267848394869;3222;3240.951385729213;3274.803511789292;3280.967190328096;5274.657147285433;5279.577633789298;5308.814191503293;5310.62825602208;5329.653572517784;5297.867553311169;5314.787408503665;5322.254884316189;5382.138857782756;5397.4602539746;4873.926891096637;4918.975405122969;4964.354633897588;4992.101421744084;4995.5753760930365;4810.254410566367;4846.636502262327;4867.975660121694;4910.41075070992;4919.975400122994;4737.644676649231;4786.377770889797;4796.160671882424;4841.612670986347;4879.609631229493;4854.12625727369;4890.24201248807;4894.583960363373;4914.04176185644;4921.064997650435;4847.684900481458;4867.537583929521;4871.8782030449165;4878.048780487807;4881.194602890519;5115.053715062725;5119.513646203604;5218.1129208034345;5225.6603320784025;5255.343082114736;5685.772569097231;5721.856953576153;5728.8854222915725;5740.397258287903;5740.6268592541355;5772.134179873011;5774.97112514439;5776.508996735282;5779.9422005779825;5804.448577385142;5340.305760251182;5359.196120581905;5400.189971504266;5405.972970135124;5430.212619170198;5872.559558033079;5890.293164820249;5892.057270836645;5903.3801450847905;5904.61619994699;5667.4615911488345;5678.4605462480995;5682.971585142048;5688.744006519716;5692.971535142381;5606.635568688022;5632.070708333079;5669.177969194444;5673.177389278531;5708.828735137952;5671.546276297969;5707.4577915098;5722.914156287659;5732.942670573324;5757.712114394348;5519.668819870821;5723.370429252779;5749.482546570829;5749.511291540266;5762.769489220468;4372.803223854934;4399.472063352418;4428.55714428561;4444.511103778582;4473.753943533072;3958.346872766019;3962.8612998544913;3974.4435778990965;3975.4235635832642;4000.879973600797;5202.193659982633;5274.446183150791;5316.813911513079;5322.973385133127;5333.919991200135;5752.654840709571;5770.88458230833;5792.333881603585;5815.011448053841;5849.034909239927;5299.152135658276;5327.440618735054;5328.8401347959625;5339.46605339463;5346.304980352607;4738.881527961828;4814.446338671098;4826.300186472942;4827.106985207748;4889.511048895153;5878.11828225761;5885.823425297248;5889.087191485327;5929.288485381781;5982.790602328898;5697.4302569742695;5709.8287051388525;5722.0844664855085;5727.6849773262875;5734.856628584319;5854.882902341844;5899.498542623754;5922.585419020627;5949.6430214187285;5950.077737950624;5529.364123125892;5566.582506312124;5632.7183640816975;5669.291338582677;5714.028615135354;5681.431856814451;5748.310202775694;5759.107338362561;5772.105323674838;5778.335491418373;5589.552835773047;5595.440455954535;5599.384067752625;5614.747336369792;5619.662820230799;5457.099578569491;5519;5531.9723401382735;5578.86052848682;5619.887602247851;5464.672119672832;5513.696746678971;5515.806946756844;5520.696361699985;5540.085885828793;5505.476979686923;5587.832365029056;5594.888102238014;5652.236948011966;5712.228849105318;5452.427495113115;5483.588730845282;5525.309336332958;5555.472230138131;5601.131824567198 20:27:35 INFO - PROCESS | 27188 | |1;ext.html;536.4796147736696;536.9341856415016;556.813986209374;561.9494245517902;570.5891757934286;39030.21939561207;40097.19805603886;40119.19761604766;40136.59863401369;40207.396889046686;43250.56749432505;43922.560774392325;44065;44137.11725765483;44205;8535.530545819978;8737.825243495126;8767.167119123673;8790.47257164569;8811.691590794324;8432.494050356998;8458.111898250687;8509.872351914726;8566.271866891291;8572.742817715447;8390.83218335633;8527.360447966395;8560.871586926201;8576.69981550646;8611.913880861173;8432.915670843275;8503.574821258973;8512.78718032048;8565.357598180162;8576.614052367659;8406.495610263342;8492.235698787077;8499.532525711084;8517.446365986252;8545.060043395222;39531.60468395337;40145.39781903274;40206.99482512961;40299.59700402988;40320.59679403227;3127.874885004597;3129.937401251962;3346.866125354983;3485.860565577399;3786.6213378662187;30252.697473025208;30256.54615180774;30310.696893031007;30675.846620766977;31554.842225788954;3904.3557812960826;3955.8219880105175;3965.484487016698;3978.5424676162324;3992.241474119937;259250;260370;261462;261528;261890;49728.99999999928;50656.746716266185;56247;56400.43599563952;56739.43260567341;59153;59666.403335966956;60298.698506508066;60338.39661603416;60469.69765151234;15184.620384490476;15467.5359739208;15482.22588870552;15498.14760188178;15591.220438978233;11943.761124777457;12080.939595301967;12087.395630218454;12105.69735756613;12134.757304853854;18587.90706046461;18700;18793.81206187948;19587.314443994394;19691.704624430644;7395.445341599401;7593.430492713069;7617.238276172338;7689.2326757410765;7783.610819459004;991.548845275398;1029.330934892326;1057.7884423115408;1064.2018486135398;1070.9518071686794;28682.71317286842;29040;29260.268493287836;29618.259543511584;29697.851510742308;979.4857699707568;1029.5264178477835;1042.9530671119667;1068.1721665709138;1108.4845546820768;13257.562528376578;13370.465181392636;13604.93197534006;13677.31613419325;13760.862391376158;296580;299797;301708;302411;302473;49147;49525.04749525019;49728.75135624299;49829.25256121161;49847;1380.8550102239121;1396.6857457072078;1397.3921344215298;1405.1288201315047;1478.8669019788272;24702.505949880542;25347.112851050126;26075.478490430465;26148;26236.475270494866;35978;36108.27783444369;36637.450438242915;40629.39055914223;40969.28853181803;288733;290232;292226;292328;293008;30456.84771576128;31178.688213117577;32340.83829580837;32446.351072977937;32635.836820815744;41980;42204.36693449662;42519.3622095675;42532.362014570426;43063.56936430721;32277.677223227467;32368.676313236567;32603;32811.343773123925;32838.507422388204;33150.336993259516;34770.65229347775;35268;35300;35362.11594710153;34548.481772772924;34896.82551587327;35181.120471988404;35382;35576.64423355733;30536;31433.842830786616;31467.685323146474;31727.682723173395;31764.36471270608;24185.879070604533;24349.26952191437;24444.633330499702;24575.385615359042;24742.134025309748 20:27:35 INFO - PROCESS | 27188 | |2;jquery.html;352.58395093789335;366.3040223575207;366.76893557059066;367.31129132875856;370.692325369943;15547.844521554782;16119;16540.66918661629;16924.661506769873;17178.226979785908;10729.409882456463;10832.133429325635;10851.782964340728;11144.777104457906;11152.609658661948;4891.975540122295;4894.804207831682;5017.49825017499;5093.872653183682;5095.4140273868425;4923.852284431473;5003.924941125886;5004.249362595603;5004.62465315101;5004.774785134678;4858.246971719372;4998.700077995314;5970.253718285215;6273.3412991635905;6281.246250449953;6191.0713392990965;6227.221597300338;6250.718717657716;6637.435817955479;6646.60120392778;6228.439440450381;6511.902321465134;6531.640759758211;6554.344565543408;6555.770548030796;20920.895395523075;21001.159953601837;21087.5782484351;21529.354119376443;22125.446863828372;2344.1443872986406;2369.680093187415;2370.5377451396985;2456.2017344362976;2456.9017239310406;12890.80663790044;13578.456861725519;13897.235652039133;14000.879929605608;14036.789448158286;1861.8324350808357;1936.6223586400658;1959.9804001960083;1968.9803101969082;1982.7125066865224;51733.7413312931;52001.219981700306;52140.739296303276;53485.73257133689;56158.15762763562;13949.651258718613;14578.41686332556;14717.852821471863;15102.848971510364;15234.314455849513;23161.3051608452;23439.296821095395;23516.059357625505;23781.643275350536;23887.7611223889;9072.591733372014;9097.49963752;9118.544072796334;9120.361574689841;9151.313651476034;7683.654235559413;7686.807829804187;7715.305622494003;7726.227377262341;7746.806329841799;7525.397968162643;7647.923520764833;7681.692732290758;7751.883721744066;7800.180980997027;1781.5635169383584;1829.8810577312431;1882.3317722208692;3013.8493075346146;3114.9844250779056;782.4405550031755;940.2290122099812;980.9944806573319;1004.42747633848;1010.3382284603597;16007.839921600867;16189.109598971934;16326.75509867353;16464.341426343053;16579.834201657828;867.2584939876315;905.0496978172893;911.289194428347;935.5462600638684;982.1013772398319;8602.18279263469;8814.603342849587;8816.162464565856;8908.020117787168;8948.73153805387;532360;545851;556128;560876;562187;68444.97332540016;70451;70765.6461717688;71001;71690.64154679298;1093.7593729379523;1141.3551343490901;1147.0708725932022;1151.0618845640777;1152.072581571826;13833.239171845646;14219.360128794022;14459.421623134956;14762.261886905826;14939;30925.381492370478;31722.36555268928;31905.521417179225;32654.51018234776;32724.181895452803;37733.4339984906;38609;38827.2234555313;39011;39309.2138157241;7136.857262854817;7345.412367010733;7377.741779037922;7378.225286344857;7475.738349157971;8598.39811213209;10230.130438912478;10508.054275115277;11108.166887483309;11155.49800258974;9036.258685834426;9309.348345615741;9360;9522.809543809224;9539.379940303857;2981.120569432066;3905.7070719696703;8600.78498037554;9450.338476306593;9916.603335866774;6785.660716964033;7131.893021604784;7573.9242607573215;9847;9896.158826499828;8409.915900840913;9313.767155821159;9865.408075515204;9928.801423971625;10089.747756306151;9132.178103970675;9315.953420232856;9374.390664606779;9980;10141.797164056825 20:27:35 INFO - PROCESS | 27188 | |3;mootools.html;1498.2808252039017;1505.9247037648117;1686.4519031314826;1801.7027190513566;1809.3667216474228;7572.469927105105;7646.502977306472;7787.999999999993;7807.297343239107;7888.32949199318;7701.576413297266;7880.2513761192595;7900.920990790105;7970.681172753083;7976.042874855011;2311.098671518105;2334.813214942809;2338.3452633262714;2346.7066616672914;2354.587947109249;2365.550545396378;2378.8096952243777;2384.153625462953;2400.111958575321;2406.38637147528;2290.4731911660247;2342.953140937189;2357.986065991623;2366.4202270443766;2376.0377047295788;2355.740868504463;2369.1707902234252;2384.7734465225863;2401.8438801477846;2405.446747248125;2366.621340585515;2372.2764556810166;2372.2883135059415;2382.2495913787275;2396.2451827674226;7744.535327880345;7795.766127016199;7811.062672479339;7826.7651970440975;7849.607519623996;4878.634102442331;5006.1489546776775;5013.523715247045;5013.749312534395;5035.144025515671;3189.856456459465;3209.5667084943702;3277.131560136566;3280.6883346082323;3332.1169889979174;996.7458298134002;1014.1481155829139;1014.6651604970342;1029.0738335498036;1046.6755305855208;10904.291221070684;11069.612563560237;11113.055390291835;11124.721881952935;11125.777484450266;4347.260965635849;4382.671299652538;4490.618297444754;4524.932126018112;4558.772061396917;9616.182624476998;9628.133467987915;9628.422294662343;9636.566354513923;9649.9035009649;4969.35398398206;4981.775820088104;4991.550760431579;4995.700257984533;4999.725015124131;4438.533953934855;4459.665525085632;4478.328250762412;4485.304777759387;4499.055198408371;3659.469376940329;3712.7586706863967;3719.367707489679;3732.328180927459;3755.9248815024093;1152.9711757205969;1166.6383421139474;1168.363242033094;1216.6167657188134;1228.729679470515;935.5649622925237;950.4724877692809;957;1025.4462590201208;1280.1231156657718;7384.298491643285;7469.775906722807;7476.065491813523;7478.5138965967035;7492.363149132276;1137.7951968645557;1141.8116010858282;1149.4769879704713;1150.9482073306722;1170.2568868768224;5704.828855134353;5742.569307301969;5807.651540907559;5809.448102430262;5810.88378232433;9355.48544830041;9628.085331893459;9688.370255933341;9777.168940639984;9778.217742580577;9342.953285233667;9600.087991640783;9651.758706032406;9684;9709.563069661883;7279.818004549928;7357.5217610855125;7357.705691772269;7364.815879603053;7410.184879663233;6968.651567421507;7008.088948436671;7023.578585284899;7086.574805511686;7091.751788687371;8127.715529956423;8199.71301004462;8323.167683231628;8333.2916702081;8346.290565301775;8513.148685131437;8522.573871306535;8637.309015278637;8724.956375218084;8735.344849136212;6681.532292739462;6807.489438292049;6820.35206655367;6856.691448884712;6857.348551887562;7356.117265927909;7388.593627350548;7439.070116235471;7441.330280274585;7494.625268736432;6163.3836616338;7319.194888562361;7340.743073992385;7341.963290183515;7511.023566936264;6342.619442833445;6664.566803157779;6807.5575087619145;6829.453643708392;7009.929900700928;7044.330788575077;7083.610401427971;7113.928860711327;7133.607651579213;7158;6527.412532872065;6542.411182993554;6555.770548030987;6559.8032059038305;6560.8359791003695;6172.197614310111;6192.907106393318;6200.3799620037635;6225.470834979077;6238.469730072813 20:27:35 INFO - PROCESS | 27188 | |4;prototype.html;329.5995365630758;330.19761978392495;337.2967363048045;338.28115255082946;341.8478776944261;6151.784687535937;6245.562810603254;6292.276388215357;6311.652859092759;6314.652694101823;6075.908861367083;6233.719482623282;6236.469900058489;6240.282367527736;6275.058741188824;4753.643476739258;4753.714777113367;4754.66717329787;4761.880952976168;4762.333273341735;4758.619310455173;4760.880977975561;4763.595094416979;4772.785224664881;4777.784999675023;4658.860234192963;4733.384659994196;4739.194336962707;4741.739204343777;4744.383230180072;4715.858524244261;4720.881977950561;4733.763311834412;4738.981119059385;4751.64362672801;4148.211839750437;4154.584541545822;4159;4174.728642638219;4179.2059508693255;5922.644641321534;5951.851203719898;5972.134040564138;5973.910391344133;5978.372270911535;5392.460753924576;5506.834794956158;5519.613627046108;5521.061419558685;5528.170774383834;6623.9006414903815;6630.569013014138;6641.269460359356;6658;6659.167604049494;4607.14767767964;4613.6078433333205;4625.814967401334;4634.72191668501;4644.373009643688;6859.588424694484;6939.30606939302;6982.720691172347;6994.2656021117555;6995.300469952964;4695.131400690883;4703.7883295251795;4707;4716.6698331116495;4723.984343366193;4748;4753.928691069636;4756.310335001405;4763.54746299101;4768.47546769855;5497.175423686399;5531.419200983919;5536.75084621193;5539.41836107211;5541.639793413416;6572.80281591553;6742.224644165885;6758.628275444799;6759.357861003196;6767.323267673193;1607.7990251218598;1645.880801055294;1651.405494022151;1657.9751303730454;1662.102464669065;1073.983890241647;1076.9730756731144;1085.636311835544;1092.956281748737;1094.2668412163869;6172.722227499773;6238.750449982041;6262.091996660459;6263.091851681481;6296.968515157395;6830.453563714891;6831.28271531492;6842.692078856463;6846.691898864563;6852;6144.354842741537;6230.875382492325;6236.968815155895;6241.063840423973;6253.843653908598;3663.670269675742;3684.097396137963;3691.8338674759702;3702.148505843671;3717.423799311111;7133.7146514139895;7135.89296160558;7138.143422789299;7138.321859423347;7138.964305178441;6928.61892595902;6930.272321406281;6948.27043160471;6964.26875178099;7009.474289428314;7230.566166030055;7242.23956484572;7245.60149191789;7282.3809976152625;7317.231690672509;7010.509264351446;7019;7020.122484689414;7020.438364930691;7022.1924478685605;6776.695048722918;6869.141357330333;6897.758578449931;6898.482613803884;6906.827329316808;7304.671289791866;7306.232845551141;7322.048133742793;7325.267473252845;7337.70649174027;4759.286107083965;4808.687435316693;4812.783424745965;4813.807447702053;4831.227003679394;6784.728610855511;6863.6568171590225;6875.106236189264;6901.275366086488;6929.237783843672;6672.766453174116;6677.866442671022;6691.832704182434;6714.899276510759;6727.26000139994;6631.834204144935;6692.6319052450635;6720.395164435225;6723.2940541244425;6726.562773419712;6366;6551.312112228338;6559.934400655932;6567.835804104744;6586.407223349922;6667.066610674607;6695.330466953265;6703.061571380108;6710.932890671226;6717.2946840581035;6524.792913311053;6536.738530458919;6548.3124271952665;6557.639329836905;6562.704678289393 20:27:35 INFO - PROCESS | 27188 | |5;yui.html;787.2481779900194;798.5847359373123;811.6956141446957;815.1318845429618;858.7380848841103;12500.249985000906;12532.310722910237;12567.560135395262;12648.177868438557;12682.619521414372;12203.084768642366;12699.936500317508;12743.936280318585;12745.808812867814;12755.936220318908;763.0881097088981;785.5640119733546;791.4420333664752;801.4830434369857;812.0864027968536;819.573821612761;822.4284122534841;832.388194676912;835.678263868412;835.9038710548303;848.0544193224572;849.9277561407257;850.196564246787;850.3197442046369;851.5827244650138;852.2798235491031;856.246503077288;859.4542465534369;860.5611138319503;862.0603542139067;629.7386584567399;634.8095571328629;635.7298148287006;637.7225906730587;639.9808005759835;13791;13915.58253252404;13939.581812545639;14012.22932738699;14019.859801402059;12394.256344619353;12808;12824.166429182073;13081.542146024938;13135.0805443619;10657.733556661145;10745.409002504859;10818.729531761768;10872.402017889013;11094.057005154491;3584.3727347714307;3626.564812222524;3645.580758212813;3691.667749902522;3692.3538380783257;48873.26690099651;49661.751691241676;49761;49796.25305620419;49882;10146.492675366202;10196;10214.387136771817;10274.691759247235;10399.428031458343;17800.821991780176;17825.46523604294;17915.104244787708;17949.820501794817;17975.910120449313;7058.541194822423;7177.748778792821;7304.233055529093;7345.3021962913435;7421.556062487955;4183.97908010458;4220.746755194698;4227.746335219835;4229.302165142717;4238.449001629769;2868.842213678226;2871.109955913632;2880.6543214813937;2887.9133625991253;2894.609227754226;524.0933185588876;542.4900593442152;545.5444703672478;570.6690119730546;572.27892855003;559.8439223004483;585.2713371852071;585.4660788733545;614.7725341623628;615.9568830181844;8179.182081791773;8393.328533717287;8445.155484451629;8449.408541402167;8460.111688272766;659.8152517295165;678.9592624442549;683.8700646877078;686.9862602747917;705.1397295299727;3795.1460921292487;3890.7081968851885;3916.7258291919293;3953.1698343347643;4078.2047500737663;58884.705576471846;59136;59247.703761480916;59511.107333390035;59583;50966.745166274675;51679.7416012925;51712.74143629258;51850.70373240699;52279.73860130751;46485.76757116193;46788.766056170185;47017.29474057823;47205;47580.7620961893;7853.272529512103;7965.283124518821;8014.551923682412;8155.714549990722;8275.296599789086;33344.833275833465;34094.31811363709;34550.82724586361;34591;34878.302433951685;40801.1839763209;41148.588514114475;43034.56965430306;45370.54629453663;45608.77195614133;10165.593376265162;10347.379157250289;10424.69691288589;10475.738106547093;10630.681079567625;10652.733681658021;10821.67534973952;10839.945800271264;11375.43122843871;11455.255408398427;10089.899101008896;10239.944418252708;10417.20498499333;10492.632757853744;10575.576976920836;9672.56473458682;10111.848322275024;10233.897661023295;10567.471626418803;10621.734456638645;9885.95057024739;10146.391216527032;10162.491875406053;10163.390196588229;10332.431716255678;8275.668973241003;8278.917210827814;8281.95859020701;8831.80770595987;8899.126576459506;7899.447038707235;8430.747077587683;8742.256908162622;9289.489078100769;9647.565859536197 20:27:35 INFO - PROCESS | 27188 | __end_tp_report 20:27:35 INFO - PROCESS | 27188 | __start_cc_report 20:27:35 INFO - PROCESS | 27188 | _x_x_mozilla_cycle_collect,307 20:27:35 INFO - PROCESS | 27188 | __end_cc_report 20:27:35 INFO - PROCESS | 27188 | __startTimestamp1453609655166__endTimestamp 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | ------- Summary: start ------- 20:27:35 INFO - PROCESS | 27188 | Number of tests: 6 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#0] dojo.html Cycles:165 Average:5313.53 Median:5519.00 stddev:583.33 (10.6%) stddev-sans-first:560.67 20:27:35 INFO - PROCESS | 27188 | Values: 3183.3 3222.0 3241.0 3274.8 3281.0 5274.7 5279.6 5308.8 5310.6 5329.7 5297.9 5314.8 5322.3 5382.1 5397.5 4873.9 4919.0 4964.4 4992.1 4995.6 4810.3 4846.6 4868.0 4910.4 4920.0 4737.6 4786.4 4796.2 4841.6 4879.6 4854.1 4890.2 4894.6 4914.0 4921.1 4847.7 4867.5 4871.9 4878.0 4881.2 5115.1 5119.5 5218.1 5225.7 5255.3 5685.8 5721.9 5728.9 5740.4 5740.6 5772.1 5775.0 5776.5 5779.9 5804.4 5340.3 5359.2 5400.2 5406.0 5430.2 5872.6 5890.3 5892.1 5903.4 5904.6 5667.5 5678.5 5683.0 5688.7 5693.0 5606.6 5632.1 5669.2 5673.2 5708.8 5671.5 5707.5 5722.9 5732.9 5757.7 5519.7 5723.4 5749.5 5749.5 5762.8 4372.8 4399.5 4428.6 4444.5 4473.8 3958.3 3962.9 3974.4 3975.4 4000.9 5202.2 5274.4 5316.8 5323.0 5333.9 5752.7 5770.9 5792.3 5815.0 5849.0 5299.2 5327.4 5328.8 5339.5 5346.3 4738.9 4814.4 4826.3 4827.1 4889.5 5878.1 5885.8 5889.1 5929.3 5982.8 5697.4 5709.8 5722.1 5727.7 5734.9 5854.9 5899.5 5922.6 5949.6 5950.1 5529.4 5566.6 5632.7 5669.3 5714.0 5681.4 5748.3 5759.1 5772.1 5778.3 5589.6 5595.4 5599.4 5614.7 5619.7 5457.1 5519.0 5532.0 5578.9 5619.9 5464.7 5513.7 5515.8 5520.7 5540.1 5505.5 5587.8 5594.9 5652.2 5712.2 5452.4 5483.6 5525.3 5555.5 5601.1 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#1] ext.html Cycles:180 Average:44955.98 Median:35038.97 stddev:74339.93 (212.2%) stddev-sans-first:74473.66 20:27:35 INFO - PROCESS | 27188 | Values: 536.5 536.9 556.8 561.9 570.6 39030.2 40097.2 40119.2 40136.6 40207.4 43250.6 43922.6 44065.0 44137.1 44205.0 8535.5 8737.8 8767.2 8790.5 8811.7 8432.5 8458.1 8509.9 8566.3 8572.7 8390.8 8527.4 8560.9 8576.7 8611.9 8432.9 8503.6 8512.8 8565.4 8576.6 8406.5 8492.2 8499.5 8517.4 8545.1 39531.6 40145.4 40207.0 40299.6 40320.6 3127.9 3129.9 3346.9 3485.9 3786.6 30252.7 30256.5 30310.7 30675.8 31554.8 3904.4 3955.8 3965.5 3978.5 3992.2 259250.0 260370.0 261462.0 261528.0 261890.0 49729.0 50656.7 56247.0 56400.4 56739.4 59153.0 59666.4 60298.7 60338.4 60469.7 15184.6 15467.5 15482.2 15498.1 15591.2 11943.8 12080.9 12087.4 12105.7 12134.8 18587.9 18700.0 18793.8 19587.3 19691.7 7395.4 7593.4 7617.2 7689.2 7783.6 991.5 1029.3 1057.8 1064.2 1071.0 28682.7 29040.0 29260.3 29618.3 29697.9 979.5 1029.5 1043.0 1068.2 1108.5 13257.6 13370.5 13604.9 13677.3 13760.9 296580.0 299797.0 301708.0 302411.0 302473.0 49147.0 49525.0 49728.8 49829.3 49847.0 1380.9 1396.7 1397.4 1405.1 1478.9 24702.5 25347.1 26075.5 26148.0 26236.5 35978.0 36108.3 36637.5 40629.4 40969.3 288733.0 290232.0 292226.0 292328.0 293008.0 30456.8 31178.7 32340.8 32446.4 32635.8 41980.0 42204.4 42519.4 42532.4 43063.6 32277.7 32368.7 32603.0 32811.3 32838.5 33150.3 34770.7 35268.0 35300.0 35362.1 34548.5 34896.8 35181.1 35382.0 35576.6 30536.0 31433.8 31467.7 31727.7 31764.4 24185.9 24349.3 24444.6 24575.4 24742.1 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#2] jquery.html Cycles:180 Average:28067.15 Median:5004.09 stddev:89926.94 (1797.1%) stddev-sans-first:90155.12 20:27:35 INFO - PROCESS | 27188 | Values: 352.6 366.3 366.8 367.3 370.7 15547.8 16119.0 16540.7 16924.7 17178.2 10729.4 10832.1 10851.8 11144.8 11152.6 4892.0 4894.8 5017.5 5093.9 5095.4 4923.9 5003.9 5004.2 5004.6 5004.8 4858.2 4998.7 5970.3 6273.3 6281.2 6191.1 6227.2 6250.7 6637.4 6646.6 6228.4 6511.9 6531.6 6554.3 6555.8 20920.9 21001.2 21087.6 21529.4 22125.4 2344.1 2369.7 2370.5 2456.2 2456.9 12890.8 13578.5 13897.2 14000.9 14036.8 1861.8 1936.6 1960.0 1969.0 1982.7 51733.7 52001.2 52140.7 53485.7 56158.2 13949.7 14578.4 14717.9 15102.8 15234.3 23161.3 23439.3 23516.1 23781.6 23887.8 9072.6 9097.5 9118.5 9120.4 9151.3 7683.7 7686.8 7715.3 7726.2 7746.8 7525.4 7647.9 7681.7 7751.9 7800.2 1781.6 1829.9 1882.3 3013.8 3115.0 782.4 940.2 981.0 1004.4 1010.3 16007.8 16189.1 16326.8 16464.3 16579.8 867.3 905.0 911.3 935.5 982.1 8602.2 8814.6 8816.2 8908.0 8948.7 532360.0 545851.0 556128.0 560876.0 562187.0 68445.0 70451.0 70765.6 71001.0 71690.6 1093.8 1141.4 1147.1 1151.1 1152.1 13833.2 14219.4 14459.4 14762.3 14939.0 30925.4 31722.4 31905.5 32654.5 32724.2 37733.4 38609.0 38827.2 39011.0 39309.2 7136.9 7345.4 7377.7 7378.2 7475.7 8598.4 10230.1 10508.1 11108.2 11155.5 9036.3 9309.3 9360.0 9522.8 9539.4 2981.1 3905.7 8600.8 9450.3 9916.6 6785.7 7131.9 7573.9 9847.0 9896.2 8409.9 9313.8 9865.4 9928.8 10089.7 9132.2 9316.0 9374.4 9980.0 10141.8 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#3] mootools.html Cycles:180 Average:5544.77 Median:6231.97 stddev:2854.25 (45.8%) stddev-sans-first:2846.05 20:27:35 INFO - PROCESS | 27188 | Values: 1498.3 1505.9 1686.5 1801.7 1809.4 7572.5 7646.5 7788.0 7807.3 7888.3 7701.6 7880.3 7900.9 7970.7 7976.0 2311.1 2334.8 2338.3 2346.7 2354.6 2365.6 2378.8 2384.2 2400.1 2406.4 2290.5 2343.0 2358.0 2366.4 2376.0 2355.7 2369.2 2384.8 2401.8 2405.4 2366.6 2372.3 2372.3 2382.2 2396.2 7744.5 7795.8 7811.1 7826.8 7849.6 4878.6 5006.1 5013.5 5013.7 5035.1 3189.9 3209.6 3277.1 3280.7 3332.1 996.7 1014.1 1014.7 1029.1 1046.7 10904.3 11069.6 11113.1 11124.7 11125.8 4347.3 4382.7 4490.6 4524.9 4558.8 9616.2 9628.1 9628.4 9636.6 9649.9 4969.4 4981.8 4991.6 4995.7 4999.7 4438.5 4459.7 4478.3 4485.3 4499.1 3659.5 3712.8 3719.4 3732.3 3755.9 1153.0 1166.6 1168.4 1216.6 1228.7 935.6 950.5 957.0 1025.4 1280.1 7384.3 7469.8 7476.1 7478.5 7492.4 1137.8 1141.8 1149.5 1150.9 1170.3 5704.8 5742.6 5807.7 5809.4 5810.9 9355.5 9628.1 9688.4 9777.2 9778.2 9343.0 9600.1 9651.8 9684.0 9709.6 7279.8 7357.5 7357.7 7364.8 7410.2 6968.7 7008.1 7023.6 7086.6 7091.8 8127.7 8199.7 8323.2 8333.3 8346.3 8513.1 8522.6 8637.3 8725.0 8735.3 6681.5 6807.5 6820.4 6856.7 6857.3 7356.1 7388.6 7439.1 7441.3 7494.6 6163.4 7319.2 7340.7 7342.0 7511.0 6342.6 6664.6 6807.6 6829.5 7009.9 7044.3 7083.6 7113.9 7133.6 7158.0 6527.4 6542.4 6555.8 6559.8 6560.8 6172.2 6192.9 6200.4 6225.5 6238.5 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#4] prototype.html Cycles:180 Average:5568.98 Median:6243.31 stddev:1700.17 (27.2%) stddev-sans-first:1658.84 20:27:35 INFO - PROCESS | 27188 | Values: 329.6 330.2 337.3 338.3 341.8 6151.8 6245.6 6292.3 6311.7 6314.7 6075.9 6233.7 6236.5 6240.3 6275.1 4753.6 4753.7 4754.7 4761.9 4762.3 4758.6 4760.9 4763.6 4772.8 4777.8 4658.9 4733.4 4739.2 4741.7 4744.4 4715.9 4720.9 4733.8 4739.0 4751.6 4148.2 4154.6 4159.0 4174.7 4179.2 5922.6 5951.9 5972.1 5973.9 5978.4 5392.5 5506.8 5519.6 5521.1 5528.2 6623.9 6630.6 6641.3 6658.0 6659.2 4607.1 4613.6 4625.8 4634.7 4644.4 6859.6 6939.3 6982.7 6994.3 6995.3 4695.1 4703.8 4707.0 4716.7 4724.0 4748.0 4753.9 4756.3 4763.5 4768.5 5497.2 5531.4 5536.8 5539.4 5541.6 6572.8 6742.2 6758.6 6759.4 6767.3 1607.8 1645.9 1651.4 1658.0 1662.1 1074.0 1077.0 1085.6 1093.0 1094.3 6172.7 6238.8 6262.1 6263.1 6297.0 6830.5 6831.3 6842.7 6846.7 6852.0 6144.4 6230.9 6237.0 6241.1 6253.8 3663.7 3684.1 3691.8 3702.1 3717.4 7133.7 7135.9 7138.1 7138.3 7139.0 6928.6 6930.3 6948.3 6964.3 7009.5 7230.6 7242.2 7245.6 7282.4 7317.2 7010.5 7019.0 7020.1 7020.4 7022.2 6776.7 6869.1 6897.8 6898.5 6906.8 7304.7 7306.2 7322.0 7325.3 7337.7 4759.3 4808.7 4812.8 4813.8 4831.2 6784.7 6863.7 6875.1 6901.3 6929.2 6672.8 6677.9 6691.8 6714.9 6727.3 6631.8 6692.6 6720.4 6723.3 6726.6 6366.0 6551.3 6559.9 6567.8 6586.4 6667.1 6695.3 6703.1 6710.9 6717.3 6524.8 6536.7 6548.3 6557.6 6562.7 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - PROCESS | 27188 | [#5] yui.html Cycles:180 Average:13625.51 Median:47111.15 stddev:16188.83 (34.4%) stddev-sans-first:16205.54 20:27:35 INFO - PROCESS | 27188 | Values: 787.2 798.6 811.7 815.1 858.7 12500.2 12532.3 12567.6 12648.2 12682.6 12203.1 12699.9 12743.9 12745.8 12755.9 763.1 785.6 791.4 801.5 812.1 819.6 822.4 832.4 835.7 835.9 848.1 849.9 850.2 850.3 851.6 852.3 856.2 859.5 860.6 862.1 629.7 634.8 635.7 637.7 640.0 13791.0 13915.6 13939.6 14012.2 14019.9 12394.3 12808.0 12824.2 13081.5 13135.1 10657.7 10745.4 10818.7 10872.4 11094.1 3584.4 3626.6 3645.6 3691.7 3692.4 48873.3 49661.8 49761.0 49796.3 49882.0 10146.5 10196.0 10214.4 10274.7 10399.4 17800.8 17825.5 17915.1 17949.8 17975.9 7058.5 7177.7 7304.2 7345.3 7421.6 4184.0 4220.7 4227.7 4229.3 4238.4 2868.8 2871.1 2880.7 2887.9 2894.6 524.1 542.5 545.5 570.7 572.3 559.8 585.3 585.5 614.8 616.0 8179.2 8393.3 8445.2 8449.4 8460.1 659.8 679.0 683.9 687.0 705.1 3795.1 3890.7 3916.7 3953.2 4078.2 58884.7 59136.0 59247.7 59511.1 59583.0 50966.7 51679.7 51712.7 51850.7 52279.7 46485.8 46788.8 47017.3 47205.0 47580.8 7853.3 7965.3 8014.6 8155.7 8275.3 33344.8 34094.3 34550.8 34591.0 34878.3 40801.2 41148.6 43034.6 45370.5 45608.8 10165.6 10347.4 10424.7 10475.7 10630.7 10652.7 10821.7 10839.9 11375.4 11455.3 10089.9 10239.9 10417.2 10492.6 10575.6 9672.6 10111.8 10233.9 10567.5 10621.7 9886.0 10146.4 10162.5 10163.4 10332.4 8275.7 8278.9 8282.0 8831.8 8899.1 7899.4 8430.7 8742.3 9289.5 9647.6 20:27:35 INFO - PROCESS | 27188 | -------- Summary: end -------- 20:27:35 INFO - PROCESS | 27188 | 20:27:35 INFO - TEST-INFO | 27188: exit 0 20:27:35 INFO - TEST-OK | dromaeo_css | took 1110368ms 20:27:35 INFO - TEST-START | kraken 20:27:35 INFO - operating with platform_type : linux_ 20:27:35 INFO - Initialising browser for kraken test... 20:27:35 INFO - TEST-INFO | started process 27430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pkpJo/profile http://localhost:34489/getInfo.html) 20:27:39 INFO - PROCESS | 27430 | 20:27:39 INFO - PROCESS | 27430 | (process:27501): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:27:40 INFO - PROCESS | 27430 | __metrics Screen width/height:1600/1200 20:27:40 INFO - PROCESS | 27430 | colorDepth:24 20:27:40 INFO - PROCESS | 27430 | Browser inner width/height: 1024/697 20:27:40 INFO - PROCESS | 27430 | __metrics 20:27:40 INFO - PROCESS | 27430 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:27:41 INFO - TEST-INFO | 27430: exit 0 20:27:41 INFO - Browser initialized. 20:27:41 INFO - Running cycle 1/1 for kraken test... 20:27:41 INFO - TEST-INFO | started process 27550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pkpJo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:27:42 INFO - PROCESS | 27550 | 20:27:42 INFO - PROCESS | 27550 | (process:27610): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:27:52 INFO - PROCESS | 27550 | RSS: Main: 152178688 20:27:52 INFO - PROCESS | 27550 | 20:27:55 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34489/tests/kraken/driver.html?testName=audio-beat-detection) 20:27:56 INFO - PROCESS | 27550 | RSS: Main: 154632192 20:27:56 INFO - PROCESS | 27550 | 20:27:58 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34489/tests/kraken/driver.html?testName=audio-dft) 20:27:59 INFO - PROCESS | 27550 | RSS: Main: 159449088 20:27:59 INFO - PROCESS | 27550 | 20:28:02 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34489/tests/kraken/driver.html?testName=audio-fft) 20:28:02 INFO - PROCESS | 27550 | RSS: Main: 151658496 20:28:02 INFO - PROCESS | 27550 | 20:28:04 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34489/tests/kraken/driver.html?testName=audio-oscillator) 20:28:05 INFO - PROCESS | 27550 | RSS: Main: 152690688 20:28:05 INFO - PROCESS | 27550 | 20:28:07 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34489/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:28:08 INFO - PROCESS | 27550 | RSS: Main: 153518080 20:28:08 INFO - PROCESS | 27550 | 20:28:11 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34489/tests/kraken/driver.html?testName=imaging-darkroom) 20:28:11 INFO - PROCESS | 27550 | RSS: Main: 154374144 20:28:11 INFO - PROCESS | 27550 | 20:28:15 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34489/tests/kraken/driver.html?testName=imaging-desaturate) 20:28:15 INFO - PROCESS | 27550 | RSS: Main: 154439680 20:28:15 INFO - PROCESS | 27550 | 20:28:18 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34489/tests/kraken/driver.html?testName=json-parse-financial) 20:28:19 INFO - PROCESS | 27550 | RSS: Main: 152924160 20:28:19 INFO - PROCESS | 27550 | 20:28:20 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34489/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:28:21 INFO - PROCESS | 27550 | RSS: Main: 153694208 20:28:21 INFO - PROCESS | 27550 | 20:28:23 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:28:23 INFO - PROCESS | 27550 | RSS: Main: 153088000 20:28:23 INFO - PROCESS | 27550 | 20:28:25 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:28:26 INFO - PROCESS | 27550 | RSS: Main: 154021888 20:28:26 INFO - PROCESS | 27550 | 20:28:28 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:28:29 INFO - PROCESS | 27550 | RSS: Main: 154562560 20:28:29 INFO - PROCESS | 27550 | 20:28:32 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:28:32 INFO - PROCESS | 27550 | RSS: Main: 154546176 20:28:32 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | Cycle 1(1): loaded http://localhost:34489/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34489/tests/kraken/driver.html?testName=ai-astar) 20:28:34 INFO - PROCESS | 27550 | RSS: Main: 155443200 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | __start_tp_report 20:28:34 INFO - PROCESS | 27550 | _x_x_mozilla_page_load 20:28:34 INFO - PROCESS | 27550 | _x_x_mozilla_page_load_details 20:28:34 INFO - PROCESS | 27550 | |i|pagename|runs| 20:28:34 INFO - PROCESS | 27550 | |0;ai-astar;111;107;112;112;111;124;112;109;110;111 20:28:34 INFO - PROCESS | 27550 | |1;audio-beat-detection;156;129;153;164;128;146;149;133;166;131 20:28:34 INFO - PROCESS | 27550 | |2;audio-dft;162;163;165;172;164;163;161;167;166;163 20:28:34 INFO - PROCESS | 27550 | |3;audio-fft;77;76;73;76;76;73;140;72;74;80 20:28:34 INFO - PROCESS | 27550 | |4;audio-oscillator;97;96;146;97;97;97;142;96;97;143 20:28:34 INFO - PROCESS | 27550 | |5;imaging-gaussian-blur;110;111;110;110;109;109;110;110;110;110 20:28:34 INFO - PROCESS | 27550 | |6;imaging-darkroom;148;148;148;146;147;145;149;146;147;146 20:28:34 INFO - PROCESS | 27550 | |7;imaging-desaturate;96;97;97;97;96;98;96;97;96;96 20:28:34 INFO - PROCESS | 27550 | |8;json-parse-financial;60;63;60;59;61;63;59;60;67;61 20:28:34 INFO - PROCESS | 27550 | |9;json-stringify-tinderbox;70;68;69;70;69;70;69;69;70;70 20:28:34 INFO - PROCESS | 27550 | |10;stanford-crypto-aes;81;83;84;91;83;85;83;83;84;82 20:28:34 INFO - PROCESS | 27550 | |11;stanford-crypto-ccm;123;114;118;114;118;119;130;117;119;121 20:28:34 INFO - PROCESS | 27550 | |12;stanford-crypto-pbkdf2;138;154;152;134;134;140;151;144;151;133 20:28:34 INFO - PROCESS | 27550 | |13;stanford-crypto-sha256-iterative;70;65;67;66;66;68;66;66;65;66 20:28:34 INFO - PROCESS | 27550 | __end_tp_report 20:28:34 INFO - PROCESS | 27550 | __start_cc_report 20:28:34 INFO - PROCESS | 27550 | _x_x_mozilla_cycle_collect,745 20:28:34 INFO - PROCESS | 27550 | __end_cc_report 20:28:34 INFO - PROCESS | 27550 | __startTimestamp1453609714515__endTimestamp 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | ------- Summary: start ------- 20:28:34 INFO - PROCESS | 27550 | Number of tests: 14 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#0] ai-astar Cycles:10 Average:111.90 Median:111.50 stddev:4.53 (4.1%) stddev-sans-first:4.80 20:28:34 INFO - PROCESS | 27550 | Values: 111.0 107.0 112.0 112.0 111.0 124.0 112.0 109.0 110.0 111.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:151.00 stddev:14.48 (9.6%) stddev-sans-first:14.85 20:28:34 INFO - PROCESS | 27550 | Values: 156.0 129.0 153.0 164.0 128.0 146.0 149.0 133.0 166.0 131.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:3.17 (1.9%) stddev-sans-first:3.22 20:28:34 INFO - PROCESS | 27550 | Values: 162.0 163.0 165.0 172.0 164.0 163.0 161.0 167.0 166.0 163.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:20.62 (27.1%) stddev-sans-first:21.80 20:28:34 INFO - PROCESS | 27550 | Values: 77.0 76.0 73.0 76.0 76.0 73.0 140.0 72.0 74.0 80.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#4] audio-oscillator Cycles:10 Average:110.80 Median:97.00 stddev:22.70 (23.4%) stddev-sans-first:23.53 20:28:34 INFO - PROCESS | 27550 | Values: 97.0 96.0 146.0 97.0 97.0 97.0 142.0 96.0 97.0 143.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:28:34 INFO - PROCESS | 27550 | Values: 110.0 111.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 110.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:1.25 (0.8%) stddev-sans-first:1.27 20:28:34 INFO - PROCESS | 27550 | Values: 148.0 148.0 148.0 146.0 147.0 145.0 149.0 146.0 147.0 146.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:28:34 INFO - PROCESS | 27550 | Values: 96.0 97.0 97.0 97.0 96.0 98.0 96.0 97.0 96.0 96.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:2.45 (4.0%) stddev-sans-first:2.55 20:28:34 INFO - PROCESS | 27550 | Values: 60.0 63.0 60.0 59.0 61.0 63.0 59.0 60.0 67.0 61.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 20:28:34 INFO - PROCESS | 27550 | Values: 70.0 68.0 69.0 70.0 69.0 70.0 69.0 69.0 70.0 70.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.73 (3.3%) stddev-sans-first:2.68 20:28:34 INFO - PROCESS | 27550 | Values: 81.0 83.0 84.0 91.0 83.0 85.0 83.0 83.0 84.0 82.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.00 stddev:4.67 (3.9%) stddev-sans-first:4.76 20:28:34 INFO - PROCESS | 27550 | Values: 123.0 114.0 118.0 114.0 118.0 119.0 130.0 117.0 119.0 121.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:147.50 stddev:8.35 (5.7%) stddev-sans-first:8.65 20:28:34 INFO - PROCESS | 27550 | Values: 138.0 154.0 152.0 134.0 134.0 140.0 151.0 144.0 151.0 133.0 20:28:34 INFO - PROCESS | 27550 | 20:28:34 INFO - PROCESS | 27550 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.51 (2.3%) stddev-sans-first:0.93 20:28:34 INFO - PROCESS | 27550 | Values: 70.0 65.0 67.0 66.0 66.0 68.0 66.0 66.0 65.0 66.0 20:28:34 INFO - PROCESS | 27550 | -------- Summary: end -------- 20:28:34 INFO - PROCESS | 27550 | 20:28:35 INFO - TEST-INFO | 27550: exit 0 20:28:35 INFO - TEST-OK | kraken | took 59636ms 20:28:35 INFO - TEST-START | v8_7 20:28:35 INFO - operating with platform_type : linux_ 20:28:35 INFO - Initialising browser for v8_7 test... 20:28:35 INFO - TEST-INFO | started process 27838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjkrp5k/profile http://localhost:34489/getInfo.html) 20:28:39 INFO - PROCESS | 27838 | 20:28:39 INFO - PROCESS | 27838 | (process:27908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:28:39 INFO - PROCESS | 27838 | __metrics Screen width/height:1600/1200 20:28:39 INFO - PROCESS | 27838 | colorDepth:24 20:28:39 INFO - PROCESS | 27838 | Browser inner width/height: 1024/697 20:28:39 INFO - PROCESS | 27838 | __metrics 20:28:40 INFO - PROCESS | 27838 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:28:40 INFO - TEST-INFO | 27838: exit 0 20:28:40 INFO - Browser initialized. 20:28:40 INFO - Running cycle 1/1 for v8_7 test... 20:28:40 INFO - TEST-INFO | started process 27957 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjkrp5k/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:28:42 INFO - PROCESS | 27957 | 20:28:42 INFO - PROCESS | 27957 | (process:28014): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:28:52 INFO - PROCESS | 27957 | RSS: Main: 151994368 20:28:52 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | Cycle 1(1): loaded http://localhost:34489/tests/v8_7/run.html (next: http://localhost:34489/tests/v8_7/run.html) 20:29:15 INFO - PROCESS | 27957 | RSS: Main: 151961600 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | __start_tp_report 20:29:15 INFO - PROCESS | 27957 | _x_x_mozilla_page_load 20:29:15 INFO - PROCESS | 27957 | _x_x_mozilla_page_load_details 20:29:15 INFO - PROCESS | 27957 | |i|pagename|runs| 20:29:15 INFO - PROCESS | 27957 | |0;Richards;166.5001665001665 20:29:15 INFO - PROCESS | 27957 | |1;DeltaBlue;191.05846388995033 20:29:15 INFO - PROCESS | 27957 | |2;Encrypt;279.4076557697681 20:29:15 INFO - PROCESS | 27957 | |3;Decrypt;5229.166666666667 20:29:15 INFO - PROCESS | 27957 | |4;RayTrace;1085.7763300760043 20:29:15 INFO - PROCESS | 27957 | |5;Earley;720.4610951008646 20:29:15 INFO - PROCESS | 27957 | |6;Boyer;12948.71794871795 20:29:15 INFO - PROCESS | 27957 | |7;RegExp;40760 20:29:15 INFO - PROCESS | 27957 | |8;Splay;588.7521968365554 20:29:15 INFO - PROCESS | 27957 | |9;NavierStokes;4822.115384615385 20:29:15 INFO - PROCESS | 27957 | __end_tp_report 20:29:15 INFO - PROCESS | 27957 | __startTimestamp1453609755386__endTimestamp 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | ------- Summary: start ------- 20:29:15 INFO - PROCESS | 27957 | Number of tests: 10 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#0] Richards Cycles:1 Average:166.50 Median:166.50 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 166.5 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#1] DeltaBlue Cycles:1 Average:191.06 Median:191.06 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 191.1 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 279.4 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 5229.2 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#4] RayTrace Cycles:1 Average:1085.78 Median:1085.78 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 1085.8 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#5] Earley Cycles:1 Average:720.46 Median:720.46 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 720.5 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#6] Boyer Cycles:1 Average:12948.72 Median:12948.72 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 12948.7 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#7] RegExp Cycles:1 Average:40760.00 Median:40760.00 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 40760.0 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#8] Splay Cycles:1 Average:588.75 Median:588.75 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 588.8 20:29:15 INFO - PROCESS | 27957 | 20:29:15 INFO - PROCESS | 27957 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 20:29:15 INFO - PROCESS | 27957 | Values: 4822.1 20:29:15 INFO - PROCESS | 27957 | -------- Summary: end -------- 20:29:15 INFO - PROCESS | 27957 | 20:29:16 INFO - TEST-INFO | 27957: exit 0 20:29:16 INFO - TEST-OK | v8_7 | took 40812ms 20:29:16 INFO - SUITE-END | took 1210s 20:29:16 INFO - Completed test suite (00:20:10) 20:29:16 INFO - Working with test: dromaeo_css 20:29:16 INFO - Generating results file: dromaeo_css 20:29:16 INFO - Working with test: kraken 20:29:16 INFO - Generating results file: kraken 20:29:16 INFO - javascript benchmark 20:29:16 INFO - Working with test: v8_7 20:29:16 INFO - Generating results file: v8_7 20:29:16 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:16 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:29:16 INFO - process_Request line: dromaeo_css 6978.78 graph.html#tests=[[72,64,43]] 20:29:16 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:16 INFO - process_Request line: kraken 1511.50 graph.html#tests=[[232,64,43]] 20:29:16 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:29:16 INFO - process_Request line: v8_7 20252.98 graph.html#tests=[[230,64,43]] 20:29:16 INFO - RETURN: dromaeo_css: 6978.78 20:29:16 INFO - RETURN: kraken: 1511.50 20:29:16 INFO - RETURN: v8_7: 20252.98 20:29:16 INFO - javascript benchmark 20:29:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3183.267848394869, 3222.0, 3240.951385729213, 3274.803511789292, 3280.967190328096, 5274.657147285433, 5279.577633789298, 5308.814191503293, 5310.62825602208, 5329.653572517784, 5297.867553311169, 5314.787408503665, 5322.254884316189, 5382.138857782756, 5397.4602539746, 4873.926891096637, 4918.975405122969, 4964.354633897588, 4992.101421744084, 4995.5753760930365, 4810.254410566367, 4846.636502262327, 4867.975660121694, 4910.41075070992, 4919.975400122994, 4737.644676649231, 4786.377770889797, 4796.160671882424, 4841.612670986347, 4879.609631229493, 4854.12625727369, 4890.24201248807, 4894.583960363373, 4914.04176185644, 4921.064997650435, 4847.684900481458, 4867.537583929521, 4871.8782030449165, 4878.048780487807, 4881.194602890519, 5115.053715062725, 5119.513646203604, 5218.1129208034345, 5225.6603320784025, 5255.343082114736, 5685.772569097231, 5721.856953576153, 5728.8854222915725, 5740.397258287903, 5740.6268592541355, 5772.134179873011, 5774.97112514439, 5776.508996735282, 5779.9422005779825, 5804.448577385142, 5340.305760251182, 5359.196120581905, 5400.189971504266, 5405.972970135124, 5430.212619170198, 5872.559558033079, 5890.293164820249, 5892.057270836645, 5903.3801450847905, 5904.61619994699, 5667.4615911488345, 5678.4605462480995, 5682.971585142048, 5688.744006519716, 5692.971535142381, 5606.635568688022, 5632.070708333079, 5669.177969194444, 5673.177389278531, 5708.828735137952, 5671.546276297969, 5707.4577915098, 5722.914156287659, 5732.942670573324, 5757.712114394348, 5519.668819870821, 5723.370429252779, 5749.482546570829, 5749.511291540266, 5762.769489220468, 4372.803223854934, 4399.472063352418, 4428.55714428561, 4444.511103778582, 4473.753943533072, 3958.346872766019, 3962.8612998544913, 3974.4435778990965, 3975.4235635832642, 4000.879973600797, 5202.193659982633, 5274.446183150791, 5316.813911513079, 5322.973385133127, 5333.919991200135, 5752.654840709571, 5770.88458230833, 5792.333881603585, 5815.011448053841, 5849.034909239927, 5299.152135658276, 5327.440618735054, 5328.8401347959625, 5339.46605339463, 5346.304980352607, 4738.881527961828, 4814.446338671098, 4826.300186472942, 4827.106985207748, 4889.511048895153, 5878.11828225761, 5885.823425297248, 5889.087191485327, 5929.288485381781, 5982.790602328898, 5697.4302569742695, 5709.8287051388525, 5722.0844664855085, 5727.6849773262875, 5734.856628584319, 5854.882902341844, 5899.498542623754, 5922.585419020627, 5949.6430214187285, 5950.077737950624, 5529.364123125892, 5566.582506312124, 5632.7183640816975, 5669.291338582677, 5714.028615135354, 5681.431856814451, 5748.310202775694, 5759.107338362561, 5772.105323674838, 5778.335491418373, 5589.552835773047, 5595.440455954535, 5599.384067752625, 5614.747336369792, 5619.662820230799, 5457.099578569491, 5519.0, 5531.9723401382735, 5578.86052848682, 5619.887602247851, 5464.672119672832, 5513.696746678971, 5515.806946756844, 5520.696361699985, 5540.085885828793, 5505.476979686923, 5587.832365029056, 5594.888102238014, 5652.236948011966, 5712.228849105318, 5452.427495113115, 5483.588730845282, 5525.309336332958, 5555.472230138131, 5601.131824567198], "unit": "score", "name": "dojo.html", "value": 5276.34382504594}, {"lowerIsBetter": false, "replicates": [536.4796147736696, 536.9341856415016, 556.813986209374, 561.9494245517902, 570.5891757934286, 39030.21939561207, 40097.19805603886, 40119.19761604766, 40136.59863401369, 40207.396889046686, 43250.56749432505, 43922.560774392325, 44065.0, 44137.11725765483, 44205.0, 8535.530545819978, 8737.825243495126, 8767.167119123673, 8790.47257164569, 8811.691590794324, 8432.494050356998, 8458.111898250687, 8509.872351914726, 8566.271866891291, 8572.742817715447, 8390.83218335633, 8527.360447966395, 8560.871586926201, 8576.69981550646, 8611.913880861173, 8432.915670843275, 8503.574821258973, 8512.78718032048, 8565.357598180162, 8576.614052367659, 8406.495610263342, 8492.235698787077, 8499.532525711084, 8517.446365986252, 8545.060043395222, 39531.60468395337, 40145.39781903274, 40206.99482512961, 40299.59700402988, 40320.59679403227, 3127.874885004597, 3129.937401251962, 3346.866125354983, 3485.860565577399, 3786.6213378662187, 30252.697473025208, 30256.54615180774, 30310.696893031007, 30675.846620766977, 31554.842225788954, 3904.3557812960826, 3955.8219880105175, 3965.484487016698, 3978.5424676162324, 3992.241474119937, 259250.0, 260370.0, 261462.0, 261528.0, 261890.0, 49728.99999999928, 50656.746716266185, 56247.0, 56400.43599563952, 56739.43260567341, 59153.0, 59666.403335966956, 60298.698506508066, 60338.39661603416, 60469.69765151234, 15184.620384490476, 15467.5359739208, 15482.22588870552, 15498.14760188178, 15591.220438978233, 11943.761124777457, 12080.939595301967, 12087.395630218454, 12105.69735756613, 12134.757304853854, 18587.90706046461, 18700.0, 18793.81206187948, 19587.314443994394, 19691.704624430644, 7395.445341599401, 7593.430492713069, 7617.238276172338, 7689.2326757410765, 7783.610819459004, 991.548845275398, 1029.330934892326, 1057.7884423115408, 1064.2018486135398, 1070.9518071686794, 28682.71317286842, 29040.0, 29260.268493287836, 29618.259543511584, 29697.851510742308, 979.4857699707568, 1029.5264178477835, 1042.9530671119667, 1068.1721665709138, 1108.4845546820768, 13257.562528376578, 13370.465181392636, 13604.93197534006, 13677.31613419325, 13760.862391376158, 296580.0, 299797.0, 301708.0, 302411.0, 302473.0, 49147.0, 49525.04749525019, 49728.75135624299, 49829.25256121161, 49847.0, 1380.8550102239121, 1396.6857457072078, 1397.3921344215298, 1405.1288201315047, 1478.8669019788272, 24702.505949880542, 25347.112851050126, 26075.478490430465, 26148.0, 26236.475270494866, 35978.0, 36108.27783444369, 36637.450438242915, 40629.39055914223, 40969.28853181803, 288733.0, 290232.0, 292226.0, 292328.0, 293008.0, 30456.84771576128, 31178.688213117577, 32340.83829580837, 32446.351072977937, 32635.836820815744, 41980.0, 42204.36693449662, 42519.3622095675, 42532.362014570426, 43063.56936430721, 32277.677223227467, 32368.676313236567, 32603.0, 32811.343773123925, 32838.507422388204, 33150.336993259516, 34770.65229347775, 35268.0, 35300.0, 35362.11594710153, 34548.481772772924, 34896.82551587327, 35181.120471988404, 35382.0, 35576.64423355733, 30536.0, 31433.842830786616, 31467.685323146474, 31727.682723173395, 31764.36471270608, 24185.879070604533, 24349.26952191437, 24444.633330499702, 24575.385615359042, 24742.134025309748], "unit": "score", "name": "ext.html", "value": 18072.23769297519}, {"lowerIsBetter": false, "replicates": [352.58395093789335, 366.3040223575207, 366.76893557059066, 367.31129132875856, 370.692325369943, 15547.844521554782, 16119.0, 16540.66918661629, 16924.661506769873, 17178.226979785908, 10729.409882456463, 10832.133429325635, 10851.782964340728, 11144.777104457906, 11152.609658661948, 4891.975540122295, 4894.804207831682, 5017.49825017499, 5093.872653183682, 5095.4140273868425, 4923.852284431473, 5003.924941125886, 5004.249362595603, 5004.62465315101, 5004.774785134678, 4858.246971719372, 4998.700077995314, 5970.253718285215, 6273.3412991635905, 6281.246250449953, 6191.0713392990965, 6227.221597300338, 6250.718717657716, 6637.435817955479, 6646.60120392778, 6228.439440450381, 6511.902321465134, 6531.640759758211, 6554.344565543408, 6555.770548030796, 20920.895395523075, 21001.159953601837, 21087.5782484351, 21529.354119376443, 22125.446863828372, 2344.1443872986406, 2369.680093187415, 2370.5377451396985, 2456.2017344362976, 2456.9017239310406, 12890.80663790044, 13578.456861725519, 13897.235652039133, 14000.879929605608, 14036.789448158286, 1861.8324350808357, 1936.6223586400658, 1959.9804001960083, 1968.9803101969082, 1982.7125066865224, 51733.7413312931, 52001.219981700306, 52140.739296303276, 53485.73257133689, 56158.15762763562, 13949.651258718613, 14578.41686332556, 14717.852821471863, 15102.848971510364, 15234.314455849513, 23161.3051608452, 23439.296821095395, 23516.059357625505, 23781.643275350536, 23887.7611223889, 9072.591733372014, 9097.49963752, 9118.544072796334, 9120.361574689841, 9151.313651476034, 7683.654235559413, 7686.807829804187, 7715.305622494003, 7726.227377262341, 7746.806329841799, 7525.397968162643, 7647.923520764833, 7681.692732290758, 7751.883721744066, 7800.180980997027, 1781.5635169383584, 1829.8810577312431, 1882.3317722208692, 3013.8493075346146, 3114.9844250779056, 782.4405550031755, 940.2290122099812, 980.9944806573319, 1004.42747633848, 1010.3382284603597, 16007.839921600867, 16189.109598971934, 16326.75509867353, 16464.341426343053, 16579.834201657828, 867.2584939876315, 905.0496978172893, 911.289194428347, 935.5462600638684, 982.1013772398319, 8602.18279263469, 8814.603342849587, 8816.162464565856, 8908.020117787168, 8948.73153805387, 532360.0, 545851.0, 556128.0, 560876.0, 562187.0, 68444.97332540016, 70451.0, 70765.6461717688, 71001.0, 71690.64154679298, 1093.7593729379523, 1141.3551343490901, 1147.0708725932022, 1151.0618845640777, 1152.072581571826, 13833.239171845646, 14219.360128794022, 14459.421623134956, 14762.261886905826, 14939.0, 30925.381492370478, 31722.36555268928, 31905.521417179225, 32654.51018234776, 32724.181895452803, 37733.4339984906, 38609.0, 38827.2234555313, 39011.0, 39309.2138157241, 7136.857262854817, 7345.412367010733, 7377.741779037922, 7378.225286344857, 7475.738349157971, 8598.39811213209, 10230.130438912478, 10508.054275115277, 11108.166887483309, 11155.49800258974, 9036.258685834426, 9309.348345615741, 9360.0, 9522.809543809224, 9539.379940303857, 2981.120569432066, 3905.7070719696703, 8600.78498037554, 9450.338476306593, 9916.603335866774, 6785.660716964033, 7131.893021604784, 7573.9242607573215, 9847.0, 9896.158826499828, 8409.915900840913, 9313.767155821159, 9865.408075515204, 9928.801423971625, 10089.747756306151, 9132.178103970675, 9315.953420232856, 9374.390664606779, 9980.0, 10141.797164056825], "unit": "score", "name": "jquery.html", "value": 8604.319335666107}, {"lowerIsBetter": false, "replicates": [1498.2808252039017, 1505.9247037648117, 1686.4519031314826, 1801.7027190513566, 1809.3667216474228, 7572.469927105105, 7646.502977306472, 7787.999999999993, 7807.297343239107, 7888.32949199318, 7701.576413297266, 7880.2513761192595, 7900.920990790105, 7970.681172753083, 7976.042874855011, 2311.098671518105, 2334.813214942809, 2338.3452633262714, 2346.7066616672914, 2354.587947109249, 2365.550545396378, 2378.8096952243777, 2384.153625462953, 2400.111958575321, 2406.38637147528, 2290.4731911660247, 2342.953140937189, 2357.986065991623, 2366.4202270443766, 2376.0377047295788, 2355.740868504463, 2369.1707902234252, 2384.7734465225863, 2401.8438801477846, 2405.446747248125, 2366.621340585515, 2372.2764556810166, 2372.2883135059415, 2382.2495913787275, 2396.2451827674226, 7744.535327880345, 7795.766127016199, 7811.062672479339, 7826.7651970440975, 7849.607519623996, 4878.634102442331, 5006.1489546776775, 5013.523715247045, 5013.749312534395, 5035.144025515671, 3189.856456459465, 3209.5667084943702, 3277.131560136566, 3280.6883346082323, 3332.1169889979174, 996.7458298134002, 1014.1481155829139, 1014.6651604970342, 1029.0738335498036, 1046.6755305855208, 10904.291221070684, 11069.612563560237, 11113.055390291835, 11124.721881952935, 11125.777484450266, 4347.260965635849, 4382.671299652538, 4490.618297444754, 4524.932126018112, 4558.772061396917, 9616.182624476998, 9628.133467987915, 9628.422294662343, 9636.566354513923, 9649.9035009649, 4969.35398398206, 4981.775820088104, 4991.550760431579, 4995.700257984533, 4999.725015124131, 4438.533953934855, 4459.665525085632, 4478.328250762412, 4485.304777759387, 4499.055198408371, 3659.469376940329, 3712.7586706863967, 3719.367707489679, 3732.328180927459, 3755.9248815024093, 1152.9711757205969, 1166.6383421139474, 1168.363242033094, 1216.6167657188134, 1228.729679470515, 935.5649622925237, 950.4724877692809, 957.0, 1025.4462590201208, 1280.1231156657718, 7384.298491643285, 7469.775906722807, 7476.065491813523, 7478.5138965967035, 7492.363149132276, 1137.7951968645557, 1141.8116010858282, 1149.4769879704713, 1150.9482073306722, 1170.2568868768224, 5704.828855134353, 5742.569307301969, 5807.651540907559, 5809.448102430262, 5810.88378232433, 9355.48544830041, 9628.085331893459, 9688.370255933341, 9777.168940639984, 9778.217742580577, 9342.953285233667, 9600.087991640783, 9651.758706032406, 9684.0, 9709.563069661883, 7279.818004549928, 7357.5217610855125, 7357.705691772269, 7364.815879603053, 7410.184879663233, 6968.651567421507, 7008.088948436671, 7023.578585284899, 7086.574805511686, 7091.751788687371, 8127.715529956423, 8199.71301004462, 8323.167683231628, 8333.2916702081, 8346.290565301775, 8513.148685131437, 8522.573871306535, 8637.309015278637, 8724.956375218084, 8735.344849136212, 6681.532292739462, 6807.489438292049, 6820.35206655367, 6856.691448884712, 6857.348551887562, 7356.117265927909, 7388.593627350548, 7439.070116235471, 7441.330280274585, 7494.625268736432, 6163.3836616338, 7319.194888562361, 7340.743073992385, 7341.963290183515, 7511.023566936264, 6342.619442833445, 6664.566803157779, 6807.5575087619145, 6829.453643708392, 7009.929900700928, 7044.330788575077, 7083.610401427971, 7113.928860711327, 7133.607651579213, 7158.0, 6527.412532872065, 6542.411182993554, 6555.770548030987, 6559.8032059038305, 6560.8359791003695, 6172.197614310111, 6192.907106393318, 6200.3799620037635, 6225.470834979077, 6238.469730072813], "unit": "score", "name": "mootools.html", "value": 4566.852421440853}, {"lowerIsBetter": false, "replicates": [329.5995365630758, 330.19761978392495, 337.2967363048045, 338.28115255082946, 341.8478776944261, 6151.784687535937, 6245.562810603254, 6292.276388215357, 6311.652859092759, 6314.652694101823, 6075.908861367083, 6233.719482623282, 6236.469900058489, 6240.282367527736, 6275.058741188824, 4753.643476739258, 4753.714777113367, 4754.66717329787, 4761.880952976168, 4762.333273341735, 4758.619310455173, 4760.880977975561, 4763.595094416979, 4772.785224664881, 4777.784999675023, 4658.860234192963, 4733.384659994196, 4739.194336962707, 4741.739204343777, 4744.383230180072, 4715.858524244261, 4720.881977950561, 4733.763311834412, 4738.981119059385, 4751.64362672801, 4148.211839750437, 4154.584541545822, 4159.0, 4174.728642638219, 4179.2059508693255, 5922.644641321534, 5951.851203719898, 5972.134040564138, 5973.910391344133, 5978.372270911535, 5392.460753924576, 5506.834794956158, 5519.613627046108, 5521.061419558685, 5528.170774383834, 6623.9006414903815, 6630.569013014138, 6641.269460359356, 6658.0, 6659.167604049494, 4607.14767767964, 4613.6078433333205, 4625.814967401334, 4634.72191668501, 4644.373009643688, 6859.588424694484, 6939.30606939302, 6982.720691172347, 6994.2656021117555, 6995.300469952964, 4695.131400690883, 4703.7883295251795, 4707.0, 4716.6698331116495, 4723.984343366193, 4748.0, 4753.928691069636, 4756.310335001405, 4763.54746299101, 4768.47546769855, 5497.175423686399, 5531.419200983919, 5536.75084621193, 5539.41836107211, 5541.639793413416, 6572.80281591553, 6742.224644165885, 6758.628275444799, 6759.357861003196, 6767.323267673193, 1607.7990251218598, 1645.880801055294, 1651.405494022151, 1657.9751303730454, 1662.102464669065, 1073.983890241647, 1076.9730756731144, 1085.636311835544, 1092.956281748737, 1094.2668412163869, 6172.722227499773, 6238.750449982041, 6262.091996660459, 6263.091851681481, 6296.968515157395, 6830.453563714891, 6831.28271531492, 6842.692078856463, 6846.691898864563, 6852.0, 6144.354842741537, 6230.875382492325, 6236.968815155895, 6241.063840423973, 6253.843653908598, 3663.670269675742, 3684.097396137963, 3691.8338674759702, 3702.148505843671, 3717.423799311111, 7133.7146514139895, 7135.89296160558, 7138.143422789299, 7138.321859423347, 7138.964305178441, 6928.61892595902, 6930.272321406281, 6948.27043160471, 6964.26875178099, 7009.474289428314, 7230.566166030055, 7242.23956484572, 7245.60149191789, 7282.3809976152625, 7317.231690672509, 7010.509264351446, 7019.0, 7020.122484689414, 7020.438364930691, 7022.1924478685605, 6776.695048722918, 6869.141357330333, 6897.758578449931, 6898.482613803884, 6906.827329316808, 7304.671289791866, 7306.232845551141, 7322.048133742793, 7325.267473252845, 7337.70649174027, 4759.286107083965, 4808.687435316693, 4812.783424745965, 4813.807447702053, 4831.227003679394, 6784.728610855511, 6863.6568171590225, 6875.106236189264, 6901.275366086488, 6929.237783843672, 6672.766453174116, 6677.866442671022, 6691.832704182434, 6714.899276510759, 6727.26000139994, 6631.834204144935, 6692.6319052450635, 6720.395164435225, 6723.2940541244425, 6726.562773419712, 6366.0, 6551.312112228338, 6559.934400655932, 6567.835804104744, 6586.407223349922, 6667.066610674607, 6695.330466953265, 6703.061571380108, 6710.932890671226, 6717.2946840581035, 6524.792913311053, 6536.738530458919, 6548.3124271952665, 6557.639329836905, 6562.704678289393], "unit": "score", "name": "prototype.html", "value": 5006.05731975427}, {"lowerIsBetter": false, "replicates": [787.2481779900194, 798.5847359373123, 811.6956141446957, 815.1318845429618, 858.7380848841103, 12500.249985000906, 12532.310722910237, 12567.560135395262, 12648.177868438557, 12682.619521414372, 12203.084768642366, 12699.936500317508, 12743.936280318585, 12745.808812867814, 12755.936220318908, 763.0881097088981, 785.5640119733546, 791.4420333664752, 801.4830434369857, 812.0864027968536, 819.573821612761, 822.4284122534841, 832.388194676912, 835.678263868412, 835.9038710548303, 848.0544193224572, 849.9277561407257, 850.196564246787, 850.3197442046369, 851.5827244650138, 852.2798235491031, 856.246503077288, 859.4542465534369, 860.5611138319503, 862.0603542139067, 629.7386584567399, 634.8095571328629, 635.7298148287006, 637.7225906730587, 639.9808005759835, 13791.0, 13915.58253252404, 13939.581812545639, 14012.22932738699, 14019.859801402059, 12394.256344619353, 12808.0, 12824.166429182073, 13081.542146024938, 13135.0805443619, 10657.733556661145, 10745.409002504859, 10818.729531761768, 10872.402017889013, 11094.057005154491, 3584.3727347714307, 3626.564812222524, 3645.580758212813, 3691.667749902522, 3692.3538380783257, 48873.26690099651, 49661.751691241676, 49761.0, 49796.25305620419, 49882.0, 10146.492675366202, 10196.0, 10214.387136771817, 10274.691759247235, 10399.428031458343, 17800.821991780176, 17825.46523604294, 17915.104244787708, 17949.820501794817, 17975.910120449313, 7058.541194822423, 7177.748778792821, 7304.233055529093, 7345.3021962913435, 7421.556062487955, 4183.97908010458, 4220.746755194698, 4227.746335219835, 4229.302165142717, 4238.449001629769, 2868.842213678226, 2871.109955913632, 2880.6543214813937, 2887.9133625991253, 2894.609227754226, 524.0933185588876, 542.4900593442152, 545.5444703672478, 570.6690119730546, 572.27892855003, 559.8439223004483, 585.2713371852071, 585.4660788733545, 614.7725341623628, 615.9568830181844, 8179.182081791773, 8393.328533717287, 8445.155484451629, 8449.408541402167, 8460.111688272766, 659.8152517295165, 678.9592624442549, 683.8700646877078, 686.9862602747917, 705.1397295299727, 3795.1460921292487, 3890.7081968851885, 3916.7258291919293, 3953.1698343347643, 4078.2047500737663, 58884.705576471846, 59136.0, 59247.703761480916, 59511.107333390035, 59583.0, 50966.745166274675, 51679.7416012925, 51712.74143629258, 51850.70373240699, 52279.73860130751, 46485.76757116193, 46788.766056170185, 47017.29474057823, 47205.0, 47580.7620961893, 7853.272529512103, 7965.283124518821, 8014.551923682412, 8155.714549990722, 8275.296599789086, 33344.833275833465, 34094.31811363709, 34550.82724586361, 34591.0, 34878.302433951685, 40801.1839763209, 41148.588514114475, 43034.56965430306, 45370.54629453663, 45608.77195614133, 10165.593376265162, 10347.379157250289, 10424.69691288589, 10475.738106547093, 10630.681079567625, 10652.733681658021, 10821.67534973952, 10839.945800271264, 11375.43122843871, 11455.255408398427, 10089.899101008896, 10239.944418252708, 10417.20498499333, 10492.632757853744, 10575.576976920836, 9672.56473458682, 10111.848322275024, 10233.897661023295, 10567.471626418803, 10621.734456638645, 9885.95057024739, 10146.391216527032, 10162.491875406053, 10163.390196588229, 10332.431716255678, 8275.668973241003, 8278.917210827814, 8281.95859020701, 8831.80770595987, 8899.126576459506, 7899.447038707235, 8430.747077587683, 8742.256908162622, 9289.489078100769, 9647.565859536197], "unit": "score", "name": "yui.html", "value": 6158.371235960997}], "name": "dromaeo_css", "value": 6978.777174446473}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 112.0, 111.0, 124.0, 112.0, 109.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 153.0, 164.0, 128.0, 146.0, 149.0, 133.0, 166.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 165.0, 172.0, 164.0, 163.0, 161.0, 167.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 73.0, 76.0, 76.0, 73.0, 140.0, 72.0, 74.0, 80.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 146.0, 97.0, 97.0, 97.0, 142.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.8}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 146.0, 147.0, 145.0, 149.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 96.0, 98.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [60.0, 63.0, 60.0, 59.0, 61.0, 63.0, 59.0, 60.0, 67.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 70.0, 69.0, 70.0, 69.0, 69.0, 70.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 91.0, 83.0, 85.0, 83.0, 83.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [123.0, 114.0, 118.0, 114.0, 118.0, 119.0, 130.0, 117.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [138.0, 154.0, 152.0, 134.0, 134.0, 140.0, 151.0, 144.0, 151.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [70.0, 65.0, 67.0, 66.0, 66.0, 68.0, 66.0, 66.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1511.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5001665001665], "unit": "score", "name": "Richards", "value": 212.02381199999994}, {"lowerIsBetter": false, "replicates": [191.05846388995033], "unit": "score", "name": "DeltaBlue", "value": 346.061612}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1085.7763300760043], "unit": "score", "name": "RayTrace", "value": 681.5298690000002}, {"lowerIsBetter": false, "replicates": [720.4610951008646], "unit": "score", "name": "Earley", "value": 925.050644}, {"lowerIsBetter": false, "replicates": [12948.71794871795], "unit": "score", "name": "Boyer", "value": 51.46941980198023}, {"lowerIsBetter": false, "replicates": [40760.0], "unit": "score", "name": "RegExp", "value": 22.349975466143274}, {"lowerIsBetter": false, "replicates": [588.7521968365554], "unit": "score", "name": "Splay", "value": 138.41307164179108}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 20252.982281432465}]} 20:29:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20252.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1511.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6978.78"}}} 20:29:16 INFO - Return code: 0 20:29:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:29:16 INFO - # TBPL SUCCESS # 20:29:16 INFO - Running post-action listener: _resource_record_post_action 20:29:16 INFO - Running post-run listener: _resource_record_post_run 20:29:17 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551100416; Read time: 36; Write time: 368556 20:29:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 242176000; Read time: 0; Write time: 209396 20:29:17 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 308924416; Read time: 36; Write time: 159160 20:29:17 INFO - Running post-run listener: _upload_blobber_files 20:29:17 INFO - Blob upload gear active. 20:29:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:29:17 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:29:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:29:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:29:18 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:29:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:29:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:19 INFO - (blobuploader) - INFO - Done attempting. 20:29:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:29:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:29:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:19 INFO - (blobuploader) - INFO - Done attempting. 20:29:19 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:19 INFO - Return code: 0 20:29:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:29:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afe9b981c64400098ef61bdb4422c277b768a4106d61eff260a1d4d1c996b6b6d10927f364fd8929ff077636b4637395bb107b0eb557aed0c837ae2cae8445bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c837f1fb44790c98ca752b02833e51283becbeb31d76d48dfb1f92cb68df930e11e0bd66e0790c40b1004ca84a16ae351c34df17ab396b61de3c40c838b83d1"} 20:29:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:29:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:29:19 INFO - Contents: 20:29:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afe9b981c64400098ef61bdb4422c277b768a4106d61eff260a1d4d1c996b6b6d10927f364fd8929ff077636b4637395bb107b0eb557aed0c837ae2cae8445bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c837f1fb44790c98ca752b02833e51283becbeb31d76d48dfb1f92cb68df930e11e0bd66e0790c40b1004ca84a16ae351c34df17ab396b61de3c40c838b83d1"} 20:29:19 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:19 INFO - Copying logs to upload dir... 20:29:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:29:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.952797 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-01-23 20:29:19.581343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 20:29:19.585464) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 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/Fx-Team/sha512/afe9b981c64400098ef61bdb4422c277b768a4106d61eff260a1d4d1c996b6b6d10927f364fd8929ff077636b4637395bb107b0eb557aed0c837ae2cae8445bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c837f1fb44790c98ca752b02833e51283becbeb31d76d48dfb1f92cb68df930e11e0bd66e0790c40b1004ca84a16ae351c34df17ab396b61de3c40c838b83d1"} build_url:https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/AVerNyRsSqmk4u69HnNKfw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/afe9b981c64400098ef61bdb4422c277b768a4106d61eff260a1d4d1c996b6b6d10927f364fd8929ff077636b4637395bb107b0eb557aed0c837ae2cae8445bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2c837f1fb44790c98ca752b02833e51283becbeb31d76d48dfb1f92cb68df930e11e0bd66e0790c40b1004ca84a16ae351c34df17ab396b61de3c40c838b83d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-23 20:29:19.611190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:29:19.611607) ========= 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=00204705a9daa57ed339a427000001b9-1453608491.751391-1049044401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-23 20:29:19.698693) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 20:29:19.699246) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-23 20:29:19.699878) ========= ========= Total master_lag: 0.25 =========